{"level":"warn","ts":"2026-03-30T23:46:54.953170Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-03-30T23:46:54.953589Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-03-30T23:46:54.953624Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=controller-1=https://199.204.45.216:2380,controller-2=https://199.204.45.157: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.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157:2380","--name=controller-2","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-03-30T23:46:54.953744Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-03-30T23:46:54.953788Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-30T23:46:54.953822Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-03-30T23:46:54.953877Z","caller":"embed/etcd.go:544","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-30T23:46:54.954693Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-03-30T23:46:54.954885Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller-2","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller-1=https://199.204.45.216:2380,controller-2=https://199.204.45.157: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-03-30T23:46:54.957519Z","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: 0xc00011a100}"} {"level":"info","ts":"2026-03-30T23:46:55.345776Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-03-30T23:46:55.345881Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"388.568309ms"} {"level":"info","ts":"2026-03-30T23:46:55.345930Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-03-30T23:46:55.345942Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-03-30T23:46:55.361135Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://199.204.45.216:2380","host":"199.204.45.216:2380","resolved-addr":"199.204.45.216:2380"} {"level":"info","ts":"2026-03-30T23:46:55.361161Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://199.204.45.157:2380","host":"199.204.45.157:2380","resolved-addr":"199.204.45.157:2380"} {"level":"info","ts":"2026-03-30T23:46:55.362942Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-03-30T23:46:55.411927Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-03-30T23:46:55.412016Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"f2626f6539ec0a12","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-03-30T23:46:55.412076Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-03-30T23:46:55.412223Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"f2626f6539ec0a12 switched to configuration voters=()"} {"level":"info","ts":"2026-03-30T23:46:55.412358Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"f2626f6539ec0a12 became follower at term 0"} {"level":"info","ts":"2026-03-30T23:46:55.412379Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft f2626f6539ec0a12 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"warn","ts":"2026-03-30T23:46:55.430347Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-30T23:46:55.432332Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-30T23:46:55.436417Z","caller":"storage/quota.go:93","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-03-30T23:46:55.436923Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.436941Z","caller":"rafthttp/transport.go:286","msg":"added new remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c","remote-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-03-30T23:46:55.436957Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.436974Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.438328Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.439641Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.441986Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.442025Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.442063Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c","remote-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-03-30T23:46:55.442098Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"f2626f6539ec0a12","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-30T23:46:55.442091Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.445398Z","caller":"etcdserver/server.go:499","msg":"starting initial election tick advance","election-ticks":10} {"level":"info","ts":"2026-03-30T23:46:55.445488Z","caller":"embed/etcd.go:766","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-30T23:46:55.445597Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-03-30T23:46:55.445651Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-03-30T23:46:55.445636Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-30T23:46:55.445720Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-30T23:46:55.445750Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-30T23:46:55.447126Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1116","msg":"f2626f6539ec0a12 [term: 0] received a MsgHeartbeat message with higher term from 4e98569549cc430c [term: 2]"} {"level":"info","ts":"2026-03-30T23:46:55.447188Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"f2626f6539ec0a12 became follower at term 2"} {"level":"info","ts":"2026-03-30T23:46:55.447210Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: f2626f6539ec0a12 elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-03-30T23:46:55.447475Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"f2626f6539ec0a12","to":"4e98569549cc430c","stream-type":"stream Message"} {"level":"info","ts":"2026-03-30T23:46:55.447534Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.447576Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.448103Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"f2626f6539ec0a12","to":"4e98569549cc430c","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-03-30T23:46:55.448150Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.448817Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"f2626f6539ec0a12","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-30T23:46:55.448853Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-30T23:46:55.453727Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.455977Z","caller":"rafthttp/http.go:258","msg":"receiving database snapshot","local-member-id":"f2626f6539ec0a12","remote-snapshot-sender-id":"4e98569549cc430c","incoming-snapshot-index":554,"incoming-snapshot-message-size-bytes":8201,"incoming-snapshot-message-size":"8.2 kB"} {"level":"info","ts":"2026-03-30T23:46:55.459630Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.464970Z","caller":"snap/db.go:65","msg":"saved database snapshot to disk","path":"/var/lib/etcd/member/snap/000000000000022a.snap.db","bytes":835584,"size":"836 kB"} {"level":"info","ts":"2026-03-30T23:46:55.465054Z","caller":"rafthttp/http.go:287","msg":"received and saved database snapshot","local-member-id":"f2626f6539ec0a12","remote-snapshot-sender-id":"4e98569549cc430c","incoming-snapshot-index":554,"incoming-snapshot-size-bytes":835584,"incoming-snapshot-size":"836 kB","download-took":"9.665469ms"} {"level":"info","ts":"2026-03-30T23:46:55.465337Z","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: 554, term: 2]"} {"level":"info","ts":"2026-03-30T23:46:55.465480Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"f2626f6539ec0a12 switched to configuration voters=(5663371730606637836) learners=(17465644785450355218)"} {"level":"info","ts":"2026-03-30T23:46:55.465529Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1935","msg":"f2626f6539ec0a12 [commit: 554, lastindex: 554, lastterm: 2] restored snapshot [index: 554, term: 2]"} {"level":"info","ts":"2026-03-30T23:46:55.465660Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1844","msg":"f2626f6539ec0a12 [commit: 554] restored snapshot [index: 554, term: 2]"} {"level":"info","ts":"2026-03-30T23:46:55.465778Z","caller":"etcdserver/server.go:1007","msg":"applying snapshot","current-snapshot-index":0,"current-applied-index":0,"incoming-leader-snapshot-index":554,"incoming-leader-snapshot-term":2} {"level":"info","ts":"2026-03-30T23:46:55.470417Z","caller":"etcdserver/raft.go:276","msg":"applied incoming Raft snapshot","snapshot-index":554} {"level":"info","ts":"2026-03-30T23:46:55.470633Z","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: 0xc00011a940}"} {"level":"info","ts":"2026-03-30T23:46:55.477486Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-03-30T23:46:55.477560Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.971838ms"} {"level":"info","ts":"2026-03-30T23:46:55.477717Z","caller":"etcdserver/server.go:1055","msg":"restoring lease store"} {"level":"info","ts":"2026-03-30T23:46:55.478894Z","caller":"etcdserver/server.go:1059","msg":"restored lease store"} {"level":"info","ts":"2026-03-30T23:46:55.478916Z","caller":"etcdserver/server.go:1062","msg":"restoring mvcc store"} {"level":"info","ts":"2026-03-30T23:46:55.481707Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":523} {"level":"info","ts":"2026-03-30T23:46:55.481734Z","caller":"etcdserver/server.go:1070","msg":"restored mvcc store","consistent-index":554} {"level":"info","ts":"2026-03-30T23:46:55.481743Z","caller":"etcdserver/server.go:1090","msg":"restoring alarm store"} {"level":"info","ts":"2026-03-30T23:46:55.481761Z","caller":"etcdserver/server.go:1078","msg":"closing old backend file"} {"level":"info","ts":"2026-03-30T23:46:55.483254Z","caller":"etcdserver/server.go:1080","msg":"closed old backend file"} {"level":"info","ts":"2026-03-30T23:46:55.483548Z","caller":"etcdserver/server.go:1096","msg":"restored alarm store"} {"level":"info","ts":"2026-03-30T23:46:55.483563Z","caller":"etcdserver/server.go:1099","msg":"restoring auth store"} {"level":"info","ts":"2026-03-30T23:46:55.483594Z","caller":"etcdserver/server.go:1103","msg":"restored auth store"} {"level":"info","ts":"2026-03-30T23:46:55.483600Z","caller":"etcdserver/server.go:1106","msg":"restoring v2 store"} {"level":"info","ts":"2026-03-30T23:46:55.483987Z","caller":"etcdserver/server.go:1115","msg":"restored v2 store"} {"level":"info","ts":"2026-03-30T23:46:55.484014Z","caller":"etcdserver/server.go:1119","msg":"restoring cluster configuration"} {"level":"info","ts":"2026-03-30T23:46:55.484055Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-03-30T23:46:55.484064Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"f2626f6539ec0a12","recovered-remote-peer-id":"4e98569549cc430c","recovered-remote-peer-urls":["https://199.204.45.216:2380"],"recovered-remote-peer-is-learner":false} {"level":"info","ts":"2026-03-30T23:46:55.484074Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"f2626f6539ec0a12","recovered-remote-peer-id":"f2626f6539ec0a12","recovered-remote-peer-urls":["https://199.204.45.157:2380"],"recovered-remote-peer-is-learner":true} {"level":"info","ts":"2026-03-30T23:46:55.484081Z","caller":"membership/cluster.go:307","msg":"set cluster version from store","cluster-version":"3.6"} {"level":"info","ts":"2026-03-30T23:46:55.484086Z","caller":"etcdserver/server.go:1123","msg":"restored cluster configuration"} {"level":"info","ts":"2026-03-30T23:46:55.484092Z","caller":"etcdserver/server.go:1124","msg":"removing old peers from network"} {"level":"info","ts":"2026-03-30T23:46:55.484100Z","caller":"rafthttp/peer.go:316","msg":"stopping remote peer","remote-peer-id":"4e98569549cc430c"} {"level":"warn","ts":"2026-03-30T23:46:55.486060Z","caller":"rafthttp/stream.go:285","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.486160Z","caller":"rafthttp/stream.go:293","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"4e98569549cc430c"} {"level":"warn","ts":"2026-03-30T23:46:55.486467Z","caller":"rafthttp/stream.go:285","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.486694Z","caller":"rafthttp/stream.go:293","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.487264Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"warn","ts":"2026-03-30T23:46:55.487760Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c","error":"context canceled"} {"level":"warn","ts":"2026-03-30T23:46:55.489926Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"4e98569549cc430c","error":"failed to read 4e98569549cc430c on stream MsgApp v2 (context canceled)"} {"level":"info","ts":"2026-03-30T23:46:55.489989Z","caller":"rafthttp/stream.go:441","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"warn","ts":"2026-03-30T23:46:55.490324Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c","error":"context canceled"} {"level":"info","ts":"2026-03-30T23:46:55.490350Z","caller":"rafthttp/stream.go:441","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.490360Z","caller":"rafthttp/peer.go:321","msg":"stopped remote peer","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.490409Z","caller":"rafthttp/transport.go:354","msg":"removed remote peer","local-member-id":"f2626f6539ec0a12","removed-remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.490444Z","caller":"etcdserver/server.go:1129","msg":"removed old peers from network"} {"level":"info","ts":"2026-03-30T23:46:55.490480Z","caller":"etcdserver/server.go:1130","msg":"adding peers from new cluster configuration"} {"level":"info","ts":"2026-03-30T23:46:55.490509Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.490565Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.493179Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.493293Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.493451Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.493513Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c","remote-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-03-30T23:46:55.493518Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.493501Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.493536Z","caller":"etcdserver/server.go:1139","msg":"added peers from new cluster configuration"} {"level":"info","ts":"2026-03-30T23:46:55.493646Z","caller":"etcdserver/server.go:1015","msg":"applied snapshot","current-snapshot-index":554,"current-applied-index":554,"incoming-leader-snapshot-index":554,"incoming-leader-snapshot-term":2} {"level":"info","ts":"2026-03-30T23:46:55.502073Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"f2626f6539ec0a12","to":"4e98569549cc430c","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-03-30T23:46:55.502099Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.502131Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.502255Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.504790Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.504833Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"f2626f6539ec0a12","to":"4e98569549cc430c","stream-type":"stream Message"} {"level":"info","ts":"2026-03-30T23:46:55.504854Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"4e98569549cc430c"} {"level":"info","ts":"2026-03-30T23:46:55.770482Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"f2626f6539ec0a12 switched to configuration voters=(5663371730606637836 17465644785450355218)"} {"level":"info","ts":"2026-03-30T23:46:55.770939Z","caller":"membership/cluster.go:550","msg":"promote member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"f2626f6539ec0a12","promoted-member-id":"f2626f6539ec0a12"} {"level":"warn","ts":"2026-03-30T23:47:02.445741Z","caller":"etcdserver/server.go:1814","msg":"failed to publish local member to cluster through raft","local-member-id":"f2626f6539ec0a12","local-member-attributes":"{Name:controller-2 ClientURLs:[https://199.204.45.157:2379]}","publish-timeout":"7s","error":"etcdserver: request timed out, possibly due to connection lost"} {"level":"info","ts":"2026-03-30T23:47:02.448535Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"f2626f6539ec0a12","local-member-attributes":"{Name:controller-2 ClientURLs:[https://199.204.45.157:2379]}","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-03-30T23:47:02.448576Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-30T23:47:02.448599Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-30T23:47:02.448817Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-30T23:47:02.448900Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-30T23:47:02.450166Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-03-30T23:47:02.450649Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-03-30T23:47:02.450761Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-03-30T23:47:02.454992Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-03-30T23:47:02.455807Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-03-30T23:47:02.457404Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32974","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.458959Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.157:49452","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.460690Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.157:49458","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.461028Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33014","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.461048Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32998","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.463956Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.157:49478","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.465436Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.157:53722","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.465518Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.157:49492","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.466099Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.157:49502","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.469620Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.157:49450","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.471059Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.157:53732","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.471523Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.157:49508","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.472009Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.157:49462","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.476249Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54516","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.487914Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54552","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.511873Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54566","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.515934Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54574","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.526927Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54598","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.535274Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54610","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.545361Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54624","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.562427Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54664","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.573778Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54680","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.583640Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54704","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.593530Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54734","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.602365Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54744","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.612224Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54766","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.622981Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54790","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.632625Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54808","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.642285Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54810","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.653763Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54826","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.665406Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54844","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.695180Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54864","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.703900Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54880","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.713971Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54902","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.724208Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54914","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.733693Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54938","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.749623Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54956","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.763677Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54980","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.773557Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55012","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.787359Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55044","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.796319Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55056","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.808781Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55068","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.820316Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55090","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.832467Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55094","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.841577Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55116","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.851668Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55132","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.862290Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55160","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.874370Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55184","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.893371Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55188","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.902275Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55198","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.912938Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55226","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.921257Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55256","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.931592Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55260","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.938878Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55272","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.948952Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55286","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.958854Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55308","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.969915Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55328","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.981078Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55330","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.989134Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55354","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:02.997582Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55368","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.007825Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55396","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.018293Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55402","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.029875Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55424","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.039623Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55432","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.049086Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55448","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.057782Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55478","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.068619Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55488","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.107279Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55522","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.116148Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55532","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.127544Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55542","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:03.188323Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55570","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:11.749797Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"223.622014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-30T23:47:14.037570Z","caller":"traceutil/trace.go:172","msg":"trace[1292670040] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:610; }","duration":"140.969116ms","start":"2026-03-30T23:47:13.896549Z","end":"2026-03-30T23:47:14.037518Z","steps":["trace[1292670040] 'read index received' (duration: 140.937384ms)","trace[1292670040] 'applied index is now lower than readState.Index' (duration: 29.562µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:47:14.037740Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"141.163332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/controller-2\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:47:14.037824Z","caller":"traceutil/trace.go:172","msg":"trace[1171547492] range","detail":"{range_begin:/registry/csinodes/controller-2; range_end:; response_count:0; response_revision:572; }","duration":"141.256256ms","start":"2026-03-30T23:47:13.896532Z","end":"2026-03-30T23:47:14.037788Z","steps":["trace[1171547492] 'agreement among raft nodes before linearized reading' (duration: 141.126541ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:47:14.038439Z","caller":"traceutil/trace.go:172","msg":"trace[1750597429] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"130.497815ms","start":"2026-03-30T23:47:13.907689Z","end":"2026-03-30T23:47:14.038186Z","steps":["trace[1750597429] 'process raft request' (duration: 129.935994ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:47:37.949328Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.129:44978","server-name":"","error":"EOF"} {"level":"info","ts":"2026-03-30T23:47:37.961587Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"f2626f6539ec0a12 switched to configuration voters=(5663371730606637836 17465644785450355218) learners=(12545232272521837301)"} {"level":"info","ts":"2026-03-30T23:47:37.961750Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"f2626f6539ec0a12","added-peer-id":"ae199e48cc6e3af5","added-peer-peer-urls":["https://199.204.45.129:2380"],"added-peer-is-learner":true} {"level":"info","ts":"2026-03-30T23:47:37.961790Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:37.961823Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:37.961930Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:37.962007Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:37.962043Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5","remote-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-03-30T23:47:37.962022Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:37.962084Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:37.962098Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"warn","ts":"2026-03-30T23:47:38.008840Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.129:45012","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:39.014973Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.129:45026","server-name":"","error":"EOF"} {"level":"info","ts":"2026-03-30T23:47:40.976703Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:40.976794Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:40.982632Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:40.982948Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"f2626f6539ec0a12","to":"ae199e48cc6e3af5","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-03-30T23:47:40.983028Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:40.985995Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"f2626f6539ec0a12","to":"ae199e48cc6e3af5","stream-type":"stream Message"} {"level":"info","ts":"2026-03-30T23:47:40.986065Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"warn","ts":"2026-03-30T23:47:41.036327Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:47:41.036794Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5","error":"EOF"} {"level":"info","ts":"2026-03-30T23:47:41.057891Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"f2626f6539ec0a12","to":"ae199e48cc6e3af5","stream-type":"stream Message"} {"level":"warn","ts":"2026-03-30T23:47:41.058093Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:41.058176Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:41.065158Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"f2626f6539ec0a12","to":"ae199e48cc6e3af5","stream-type":"stream MsgApp v2"} {"level":"warn","ts":"2026-03-30T23:47:41.065269Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:41.065308Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:41.074537Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:41.079405Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"f2626f6539ec0a12","remote-peer-id":"ae199e48cc6e3af5"} {"level":"info","ts":"2026-03-30T23:47:41.522000Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"f2626f6539ec0a12 switched to configuration voters=(5663371730606637836 12545232272521837301 17465644785450355218)"} {"level":"info","ts":"2026-03-30T23:47:41.522278Z","caller":"membership/cluster.go:550","msg":"promote member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"f2626f6539ec0a12","promoted-member-id":"ae199e48cc6e3af5"} {"level":"warn","ts":"2026-03-30T23:48:09.734048Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"139.130727ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:09.734138Z","caller":"traceutil/trace.go:172","msg":"trace[346010660] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:869; }","duration":"139.23126ms","start":"2026-03-30T23:48:09.594892Z","end":"2026-03-30T23:48:09.734123Z","steps":["trace[346010660] 'range keys from in-memory index tree' (duration: 139.089377ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:10.252426Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"197.576125ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-03-30T23:48:10.651916Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"157.205292ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-30T23:48:10.652025Z","caller":"traceutil/trace.go:172","msg":"trace[32903762] linearizableReadLoop","detail":"{readStateIndex:944; appliedIndex:943; }","duration":"264.120673ms","start":"2026-03-30T23:48:10.387887Z","end":"2026-03-30T23:48:10.652008Z","steps":["trace[32903762] 'read index received' (duration: 109.232148ms)","trace[32903762] 'applied index is now lower than readState.Index' (duration: 154.887325ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:10.652279Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"264.235116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:10.652645Z","caller":"traceutil/trace.go:172","msg":"trace[1652827109] range","detail":"{range_begin:/registry/poddisruptionbudgets; range_end:; response_count:0; response_revision:870; }","duration":"264.749878ms","start":"2026-03-30T23:48:10.387872Z","end":"2026-03-30T23:48:10.652622Z","steps":["trace[1652827109] 'agreement among raft nodes before linearized reading' (duration: 264.196024ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:10.690962Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"293.836558ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:10.691038Z","caller":"traceutil/trace.go:172","msg":"trace[1998212131] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:871; }","duration":"293.91846ms","start":"2026-03-30T23:48:10.397106Z","end":"2026-03-30T23:48:10.691024Z","steps":["trace[1998212131] 'agreement among raft nodes before linearized reading' (duration: 293.818017ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:10.691253Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.489744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:10.691330Z","caller":"traceutil/trace.go:172","msg":"trace[690466581] range","detail":"{range_begin:/registry/volumeattachments; range_end:; response_count:0; response_revision:871; }","duration":"101.561697ms","start":"2026-03-30T23:48:10.589746Z","end":"2026-03-30T23:48:10.691308Z","steps":["trace[690466581] 'agreement among raft nodes before linearized reading' (duration: 101.437513ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:10.691344Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"136.816531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:10.691505Z","caller":"traceutil/trace.go:172","msg":"trace[329828849] range","detail":"{range_begin:/registry/rolebindings; range_end:; response_count:0; response_revision:871; }","duration":"136.961274ms","start":"2026-03-30T23:48:10.554513Z","end":"2026-03-30T23:48:10.691475Z","steps":["trace[329828849] 'agreement among raft nodes before linearized reading' (duration: 136.766019ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:13.104870Z","caller":"traceutil/trace.go:172","msg":"trace[766670426] linearizableReadLoop","detail":"{readStateIndex:952; appliedIndex:952; }","duration":"145.828801ms","start":"2026-03-30T23:48:12.958961Z","end":"2026-03-30T23:48:13.104790Z","steps":["trace[766670426] 'read index received' (duration: 145.726329ms)","trace[766670426] 'applied index is now lower than readState.Index' (duration: 64.262µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:13.104949Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"145.958914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:13.105056Z","caller":"traceutil/trace.go:172","msg":"trace[41134029] range","detail":"{range_begin:/registry/horizontalpodautoscalers; range_end:; response_count:0; response_revision:877; }","duration":"146.085527ms","start":"2026-03-30T23:48:12.958949Z","end":"2026-03-30T23:48:13.105034Z","steps":["trace[41134029] 'agreement among raft nodes before linearized reading' (duration: 145.891072ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:17.325125Z","caller":"traceutil/trace.go:172","msg":"trace[1154960472] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1012; }","duration":"151.382113ms","start":"2026-03-30T23:48:17.173716Z","end":"2026-03-30T23:48:17.325098Z","steps":["trace[1154960472] 'read index received' (duration: 151.367433ms)","trace[1154960472] 'applied index is now lower than readState.Index' (duration: 13.51µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:17.325281Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"151.527556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:17.325312Z","caller":"traceutil/trace.go:172","msg":"trace[413697179] range","detail":"{range_begin:/registry/endpointslices; range_end:; response_count:0; response_revision:935; }","duration":"151.600259ms","start":"2026-03-30T23:48:17.173703Z","end":"2026-03-30T23:48:17.325303Z","steps":["trace[413697179] 'agreement among raft nodes before linearized reading' (duration: 151.497526ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:18.896654Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706697,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:18.897222Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"266.527155ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-30T23:48:18.943254Z","caller":"traceutil/trace.go:172","msg":"trace[650590405] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1020; }","duration":"547.132872ms","start":"2026-03-30T23:48:18.396097Z","end":"2026-03-30T23:48:18.943230Z","steps":["trace[650590405] 'read index received' (duration: 547.124292ms)","trace[650590405] 'applied index is now lower than readState.Index' (duration: 6.81µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:18.943469Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"547.321597ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:18.943493Z","caller":"traceutil/trace.go:172","msg":"trace[1871419675] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:941; }","duration":"547.396588ms","start":"2026-03-30T23:48:18.396090Z","end":"2026-03-30T23:48:18.943486Z","steps":["trace[1871419675] 'agreement among raft nodes before linearized reading' (duration: 547.291965ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:18.947771Z","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":725815393073706698,"received-request-id":725815393073706697} {"level":"warn","ts":"2026-03-30T23:48:18.947913Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"403.509694ms","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-03-30T23:48:18.947973Z","caller":"traceutil/trace.go:172","msg":"trace[326327106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:942; }","duration":"403.579267ms","start":"2026-03-30T23:48:18.544383Z","end":"2026-03-30T23:48:18.947963Z","steps":["trace[326327106] 'agreement among raft nodes before linearized reading' (duration: 403.439944ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:18.947996Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:18.544362Z","time spent":"403.628717ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:19.897234Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706701,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:20.398393Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706701,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T23:48:20.552876Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1101","msg":"f2626f6539ec0a12 [logterm: 2, index: 1024, vote: 0] ignored MsgPreVote from ae199e48cc6e3af5 [logterm: 2, index: 1024] at term 2: lease is not expired (remaining ticks: 10)"} {"level":"warn","ts":"2026-03-30T23:48:20.898626Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706701,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:21.220512Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.89712077s","expected-duration":"1s"} {"level":"warn","ts":"2026-03-30T23:48:21.398810Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706701,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:21.542594Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.92924ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-30T23:48:21.546099Z","caller":"traceutil/trace.go:172","msg":"trace[1446357345] linearizableReadLoop","detail":"{readStateIndex:1037; appliedIndex:1043; }","duration":"2.149767355s","start":"2026-03-30T23:48:19.396304Z","end":"2026-03-30T23:48:21.546072Z","steps":["trace[1446357345] 'read index received' (duration: 2.149761615s)","trace[1446357345] 'applied index is now lower than readState.Index' (duration: 4.39µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:21.546294Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.14997134s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:21.546331Z","caller":"traceutil/trace.go:172","msg":"trace[1310031260] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:960; }","duration":"2.15002403s","start":"2026-03-30T23:48:19.396298Z","end":"2026-03-30T23:48:21.546322Z","steps":["trace[1310031260] 'agreement among raft nodes before linearized reading' (duration: 2.149944578s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:21.549317Z","caller":"traceutil/trace.go:172","msg":"trace[585950251] transaction","detail":"{read_only:false; number_of_response:1; response_revision:969; }","duration":"320.62806ms","start":"2026-03-30T23:48:21.228666Z","end":"2026-03-30T23:48:21.549294Z","steps":["trace[585950251] 'process raft request' (duration: 320.19482ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:21.549471Z","caller":"traceutil/trace.go:172","msg":"trace[53840800] transaction","detail":"{read_only:false; number_of_response:0; response_revision:969; }","duration":"243.489215ms","start":"2026-03-30T23:48:21.305968Z","end":"2026-03-30T23:48:21.549457Z","steps":["trace[53840800] 'process raft request' (duration: 242.988724ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:21.549650Z","caller":"traceutil/trace.go:172","msg":"trace[184624539] transaction","detail":"{read_only:false; number_of_response:1; response_revision:969; }","duration":"320.810523ms","start":"2026-03-30T23:48:21.228829Z","end":"2026-03-30T23:48:21.549639Z","steps":["trace[184624539] 'process raft request' (duration: 320.099366ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:21.549659Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.228655Z","time spent":"320.728892ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:21.549735Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.228820Z","time spent":"320.851344ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T23:48:21.549897Z","caller":"traceutil/trace.go:172","msg":"trace[1936661230] transaction","detail":"{read_only:false; number_of_response:0; response_revision:969; }","duration":"321.944079ms","start":"2026-03-30T23:48:21.227942Z","end":"2026-03-30T23:48:21.549886Z","steps":["trace[1936661230] 'process raft request' (duration: 320.883944ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:21.549946Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.227924Z","time spent":"321.997741ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T23:48:21.550345Z","caller":"traceutil/trace.go:172","msg":"trace[1139283781] transaction","detail":"{read_only:false; number_of_response:0; response_revision:969; }","duration":"241.034197ms","start":"2026-03-30T23:48:21.309301Z","end":"2026-03-30T23:48:21.550335Z","steps":["trace[1139283781] 'process raft request' (duration: 239.695116ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:21.550534Z","caller":"traceutil/trace.go:172","msg":"trace[1262838945] transaction","detail":"{read_only:false; number_of_response:1; response_revision:969; }","duration":"238.921197ms","start":"2026-03-30T23:48:21.311600Z","end":"2026-03-30T23:48:21.550521Z","steps":["trace[1262838945] 'process raft request' (duration: 237.981144ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:21.550677Z","caller":"traceutil/trace.go:172","msg":"trace[732874473] transaction","detail":"{read_only:false; number_of_response:0; response_revision:969; }","duration":"242.983624ms","start":"2026-03-30T23:48:21.307679Z","end":"2026-03-30T23:48:21.550663Z","steps":["trace[732874473] 'process raft request' (duration: 241.297064ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:21.550965Z","caller":"traceutil/trace.go:172","msg":"trace[1236601182] transaction","detail":"{read_only:false; number_of_response:0; response_revision:969; }","duration":"237.402941ms","start":"2026-03-30T23:48:21.313539Z","end":"2026-03-30T23:48:21.550942Z","steps":["trace[1236601182] 'process raft request' (duration: 236.355406ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:21.552450Z","caller":"traceutil/trace.go:172","msg":"trace[997859601] transaction","detail":"{read_only:false; number_of_response:1; response_revision:969; }","duration":"219.819696ms","start":"2026-03-30T23:48:21.332614Z","end":"2026-03-30T23:48:21.552434Z","steps":["trace[997859601] 'process raft request' (duration: 219.784326ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:21.552563Z","caller":"traceutil/trace.go:172","msg":"trace[363315535] transaction","detail":"{read_only:false; number_of_response:1; response_revision:969; }","duration":"236.257215ms","start":"2026-03-30T23:48:21.316295Z","end":"2026-03-30T23:48:21.552552Z","steps":["trace[363315535] 'process raft request' (duration: 233.653393ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:21.552667Z","caller":"traceutil/trace.go:172","msg":"trace[1359080223] transaction","detail":"{read_only:false; number_of_response:1; response_revision:969; }","duration":"227.113688ms","start":"2026-03-30T23:48:21.325545Z","end":"2026-03-30T23:48:21.552659Z","steps":["trace[1359080223] 'process raft request' (duration: 226.75347ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.047360Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706713,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:22.197150Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"399.842778ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-30T23:48:22.240464Z","caller":"traceutil/trace.go:172","msg":"trace[1685629377] linearizableReadLoop","detail":"{readStateIndex:1090; appliedIndex:1092; }","duration":"694.254492ms","start":"2026-03-30T23:48:21.546187Z","end":"2026-03-30T23:48:22.240442Z","steps":["trace[1685629377] 'read index received' (duration: 694.243012ms)","trace[1685629377] 'applied index is now lower than readState.Index' (duration: 9.71µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:22.240752Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"746.305533ms","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-03-30T23:48:22.240788Z","caller":"traceutil/trace.go:172","msg":"trace[293309490] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:980; }","duration":"746.358474ms","start":"2026-03-30T23:48:21.494416Z","end":"2026-03-30T23:48:22.240774Z","steps":["trace[293309490] 'agreement among raft nodes before linearized reading' (duration: 746.18487ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.240821Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.494390Z","time spent":"746.422275ms","remote":"127.0.0.1:54926","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-03-30T23:48:22.240884Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.528586813s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:22.240925Z","caller":"traceutil/trace.go:172","msg":"trace[653811477] range","detail":"{range_begin:/registry/controllers; range_end:; response_count:0; response_revision:980; }","duration":"2.528629965s","start":"2026-03-30T23:48:19.712282Z","end":"2026-03-30T23:48:22.240912Z","steps":["trace[653811477] 'agreement among raft nodes before linearized reading' (duration: 2.528537472s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.240949Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:19.712257Z","time spent":"2.528684605s","remote":"127.0.0.1:54846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":28,"request content":"key:\"/registry/controllers\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:22.240908Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.447041166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:22.240937Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.191819823s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:22.240974Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.653578818s","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-03-30T23:48:22.241009Z","caller":"traceutil/trace.go:172","msg":"trace[719092967] range","detail":"{range_begin:/registry/podtemplates; range_end:; response_count:0; response_revision:980; }","duration":"2.447164139s","start":"2026-03-30T23:48:19.793823Z","end":"2026-03-30T23:48:22.240987Z","steps":["trace[719092967] 'agreement among raft nodes before linearized reading' (duration: 2.446959055s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:22.241034Z","caller":"traceutil/trace.go:172","msg":"trace[1756489328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:980; }","duration":"1.191923495s","start":"2026-03-30T23:48:21.049089Z","end":"2026-03-30T23:48:22.241013Z","steps":["trace[1756489328] 'agreement among raft nodes before linearized reading' (duration: 1.1917269s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:22.241055Z","caller":"traceutil/trace.go:172","msg":"trace[516142932] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:980; }","duration":"2.653720071s","start":"2026-03-30T23:48:19.587313Z","end":"2026-03-30T23:48:22.241033Z","steps":["trace[516142932] 'agreement among raft nodes before linearized reading' (duration: 2.653473336s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.241064Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:19.793804Z","time spent":"2.447250872s","remote":"127.0.0.1:54694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:22.241080Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.049070Z","time spent":"1.192000607s","remote":"127.0.0.1:32988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T23:48:22.241068Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.377148297s","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-03-30T23:48:22.241128Z","caller":"traceutil/trace.go:172","msg":"trace[1980634306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:980; }","duration":"2.377208289s","start":"2026-03-30T23:48:19.863903Z","end":"2026-03-30T23:48:22.241111Z","steps":["trace[1980634306] 'agreement among raft nodes before linearized reading' (duration: 2.377097916s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.241132Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.677084369s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:22.241162Z","caller":"traceutil/trace.go:172","msg":"trace[1864449299] range","detail":"{range_begin:/registry/volumeattachments; range_end:; response_count:0; response_revision:980; }","duration":"2.677117169s","start":"2026-03-30T23:48:19.564037Z","end":"2026-03-30T23:48:22.241154Z","steps":["trace[1864449299] 'agreement among raft nodes before linearized reading' (duration: 2.677063567s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.241160Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:19.863887Z","time spent":"2.3772651s","remote":"127.0.0.1:54926","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":"warn","ts":"2026-03-30T23:48:22.241152Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:19.587295Z","time spent":"2.653838935s","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:22.241184Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:19.563983Z","time spent":"2.677194651s","remote":"127.0.0.1:55210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:22.241795Z","caller":"traceutil/trace.go:172","msg":"trace[1343257495] transaction","detail":"{read_only:false; number_of_response:1; response_revision:980; }","duration":"682.71465ms","start":"2026-03-30T23:48:21.559064Z","end":"2026-03-30T23:48:22.241779Z","steps":["trace[1343257495] 'process raft request' (duration: 682.385032ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:22.241847Z","caller":"traceutil/trace.go:172","msg":"trace[1806586074] transaction","detail":"{read_only:false; number_of_response:1; response_revision:980; }","duration":"675.54709ms","start":"2026-03-30T23:48:21.566272Z","end":"2026-03-30T23:48:22.241819Z","steps":["trace[1806586074] 'process raft request' (duration: 675.375756ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.241957Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.559045Z","time spent":"682.793541ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":96,"response count":0,"response size":9183,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:22.242024Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.566248Z","time spent":"675.682923ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":96,"response count":0,"response size":64513,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T23:48:22.242030Z","caller":"traceutil/trace.go:172","msg":"trace[540591977] transaction","detail":"{read_only:false; number_of_response:1; response_revision:980; }","duration":"664.438827ms","start":"2026-03-30T23:48:21.577577Z","end":"2026-03-30T23:48:22.242016Z","steps":["trace[540591977] 'process raft request' (duration: 664.184052ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.242213Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.577552Z","time spent":"664.616222ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":95,"response count":0,"response size":58895,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T23:48:22.242218Z","caller":"traceutil/trace.go:172","msg":"trace[1958229276] transaction","detail":"{read_only:false; number_of_response:1; response_revision:980; }","duration":"661.695653ms","start":"2026-03-30T23:48:21.580504Z","end":"2026-03-30T23:48:22.242199Z","steps":["trace[1958229276] 'process raft request' (duration: 661.314284ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:22.242318Z","caller":"traceutil/trace.go:172","msg":"trace[1307389359] transaction","detail":"{read_only:false; number_of_response:1; response_revision:980; }","duration":"633.165008ms","start":"2026-03-30T23:48:21.609141Z","end":"2026-03-30T23:48:22.242306Z","steps":["trace[1307389359] 'process raft request' (duration: 632.870861ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.242367Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.580487Z","time spent":"661.766325ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97,"response count":0,"response size":79998,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:22.242461Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.609117Z","time spent":"633.270741ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97,"response count":0,"response size":150531,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:22.362568Z","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":725815393073706720,"received-request-id":725815393073706713} {"level":"info","ts":"2026-03-30T23:48:22.362978Z","caller":"traceutil/trace.go:172","msg":"trace[1088876834] transaction","detail":"{read_only:false; number_of_response:1; response_revision:985; }","duration":"557.425572ms","start":"2026-03-30T23:48:21.805526Z","end":"2026-03-30T23:48:22.362952Z","steps":["trace[1088876834] 'process raft request' (duration: 557.076034ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.363106Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.805506Z","time spent":"557.532354ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":96,"response count":0,"response size":9183,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T23:48:22.375900Z","caller":"traceutil/trace.go:172","msg":"trace[385018533] linearizableReadLoop","detail":"{readStateIndex:1106; appliedIndex:1107; }","duration":"135.317381ms","start":"2026-03-30T23:48:22.240569Z","end":"2026-03-30T23:48:22.375887Z","steps":["trace[385018533] 'read index received' (duration: 135.312351ms)","trace[385018533] 'applied index is now lower than readState.Index' (duration: 4.41µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:22.376057Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"559.291414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-03-30T23:48:22.376072Z","caller":"traceutil/trace.go:172","msg":"trace[1036745999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:988; }","duration":"559.322616ms","start":"2026-03-30T23:48:21.816746Z","end":"2026-03-30T23:48:22.376068Z","steps":["trace[1036745999] 'agreement among raft nodes before linearized reading' (duration: 559.219093ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.376089Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.816728Z","time spent":"559.357237ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:22.376233Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"822.64979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" limit:1 ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-03-30T23:48:22.376247Z","caller":"traceutil/trace.go:172","msg":"trace[736739714] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:988; }","duration":"822.66328ms","start":"2026-03-30T23:48:21.553579Z","end":"2026-03-30T23:48:22.376242Z","steps":["trace[736739714] 'agreement among raft nodes before linearized reading' (duration: 822.62172ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.376259Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.553546Z","time spent":"822.708601ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1036,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:22.376335Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"822.784603ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:22.376347Z","caller":"traceutil/trace.go:172","msg":"trace[549497934] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:988; }","duration":"822.797364ms","start":"2026-03-30T23:48:21.553546Z","end":"2026-03-30T23:48:22.376343Z","steps":["trace[549497934] 'agreement among raft nodes before linearized reading' (duration: 822.779273ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.376485Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"823.594043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1.gateway.networking.k8s.io\" limit:1 ","response":"range_response_count:1 size:995"} {"level":"info","ts":"2026-03-30T23:48:22.376497Z","caller":"traceutil/trace.go:172","msg":"trace[1200916781] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:988; }","duration":"823.607023ms","start":"2026-03-30T23:48:21.552887Z","end":"2026-03-30T23:48:22.376494Z","steps":["trace[1200916781] 'agreement among raft nodes before linearized reading' (duration: 823.569431ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.376510Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.552880Z","time spent":"823.627443ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":1018,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1.gateway.networking.k8s.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:22.376595Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"823.842768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" limit:1 ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-03-30T23:48:22.376607Z","caller":"traceutil/trace.go:172","msg":"trace[1820278697] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:988; }","duration":"823.854688ms","start":"2026-03-30T23:48:21.552749Z","end":"2026-03-30T23:48:22.376604Z","steps":["trace[1820278697] 'agreement among raft nodes before linearized reading' (duration: 823.819037ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.376617Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.552740Z","time spent":"823.874458ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":1033,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:22.376700Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"824.151086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" limit:1 ","response":"range_response_count:1 size:1019"} {"level":"info","ts":"2026-03-30T23:48:22.376713Z","caller":"traceutil/trace.go:172","msg":"trace[1438243037] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:988; }","duration":"824.165366ms","start":"2026-03-30T23:48:21.552544Z","end":"2026-03-30T23:48:22.376709Z","steps":["trace[1438243037] 'agreement among raft nodes before linearized reading' (duration: 824.127434ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.376723Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.552536Z","time spent":"824.183616ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":1042,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:22.376800Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"824.320509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" limit:1 ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-03-30T23:48:22.376812Z","caller":"traceutil/trace.go:172","msg":"trace[575164607] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:988; }","duration":"824.33229ms","start":"2026-03-30T23:48:21.552476Z","end":"2026-03-30T23:48:22.376808Z","steps":["trace[575164607] 'agreement among raft nodes before linearized reading' (duration: 824.299939ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.376824Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:21.552463Z","time spent":"824.35855ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1036,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:22.381187Z","caller":"traceutil/trace.go:172","msg":"trace[242958912] transaction","detail":"{read_only:false; number_of_response:1; response_revision:988; }","duration":"111.092842ms","start":"2026-03-30T23:48:22.270078Z","end":"2026-03-30T23:48:22.381171Z","steps":["trace[242958912] 'process raft request' (duration: 111.00867ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:22.388749Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"134.437521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:22.388786Z","caller":"traceutil/trace.go:172","msg":"trace[2075997947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:988; }","duration":"134.476523ms","start":"2026-03-30T23:48:22.254301Z","end":"2026-03-30T23:48:22.388778Z","steps":["trace[2075997947] 'agreement among raft nodes before linearized reading' (duration: 134.414221ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:22.672461Z","caller":"traceutil/trace.go:172","msg":"trace[954734952] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"196.507411ms","start":"2026-03-30T23:48:22.475930Z","end":"2026-03-30T23:48:22.672438Z","steps":["trace[954734952] 'process raft request' (duration: 195.736273ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:23.092177Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706728,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:23.232321Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"355.854363ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-03-30T23:48:23.445932Z","caller":"traceutil/trace.go:172","msg":"trace[674111458] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1128; }","duration":"853.806788ms","start":"2026-03-30T23:48:22.592100Z","end":"2026-03-30T23:48:23.445906Z","steps":["trace[674111458] 'read index received' (duration: 853.797818ms)","trace[674111458] 'applied index is now lower than readState.Index' (duration: 7.77µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:23.882595Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"485.825358ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:23.883000Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.290856985s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/servicecidrs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:23.883042Z","caller":"traceutil/trace.go:172","msg":"trace[769682074] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:998; }","duration":"485.936181ms","start":"2026-03-30T23:48:23.396743Z","end":"2026-03-30T23:48:23.882680Z","steps":["trace[769682074] 'range keys from in-memory index tree' (duration: 485.780057ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:23.883452Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"437.315694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-30T23:48:23.883092Z","caller":"traceutil/trace.go:172","msg":"trace[950440532] range","detail":"{range_begin:/registry/servicecidrs; range_end:; response_count:0; response_revision:998; }","duration":"1.290978887s","start":"2026-03-30T23:48:22.592090Z","end":"2026-03-30T23:48:23.883069Z","steps":["trace[950440532] 'agreement among raft nodes before linearized reading' (duration: 853.93312ms)","trace[950440532] 'range keys from in-memory index tree' (duration: 436.888493ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:23.883780Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:22.592073Z","time spent":"1.291681394s","remote":"127.0.0.1:55054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/servicecidrs\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:23.884201Z","caller":"traceutil/trace.go:172","msg":"trace[937572609] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1000; }","duration":"1.405954972s","start":"2026-03-30T23:48:22.478226Z","end":"2026-03-30T23:48:23.884181Z","steps":["trace[937572609] 'process raft request' (duration: 1.405707806s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:23.884251Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:22.478208Z","time spent":"1.406018064s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":95,"response count":0,"response size":59667,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:23.925835Z","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":725815393073706732,"received-request-id":725815393073706728} {"level":"warn","ts":"2026-03-30T23:48:23.946645Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706732,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:24.447503Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706732,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:24.652926Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"171.78555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-03-30T23:48:24.653800Z","caller":"traceutil/trace.go:172","msg":"trace[283414333] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1006; }","duration":"1.379034716s","start":"2026-03-30T23:48:23.274751Z","end":"2026-03-30T23:48:24.653786Z","steps":["trace[283414333] 'process raft request' (duration: 1.378915202s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:24.655285Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:23.274736Z","time spent":"1.379109327s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":95,"response count":0,"response size":59667,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T23:48:24.697728Z","caller":"traceutil/trace.go:172","msg":"trace[1214911941] linearizableReadLoop","detail":"{readStateIndex:1139; appliedIndex:1142; }","duration":"1.25171008s","start":"2026-03-30T23:48:23.445998Z","end":"2026-03-30T23:48:24.697708Z","steps":["trace[1214911941] 'read index received' (duration: 1.2516995s)","trace[1214911941] 'applied index is now lower than readState.Index' (duration: 8.41µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:24.697883Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.55082422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:24.697909Z","caller":"traceutil/trace.go:172","msg":"trace[865029816] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:1006; }","duration":"1.55086844s","start":"2026-03-30T23:48:23.147034Z","end":"2026-03-30T23:48:24.697902Z","steps":["trace[865029816] 'agreement among raft nodes before linearized reading' (duration: 1.550789268s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:24.697955Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:23.147012Z","time spent":"1.550937293s","remote":"127.0.0.1:54618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":28,"request content":"key:\"/registry/secrets\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:24.697985Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.972110061s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:24.698011Z","caller":"traceutil/trace.go:172","msg":"trace[1671347627] range","detail":"{range_begin:/registry/priorityclasses; range_end:; response_count:0; response_revision:1006; }","duration":"1.972138821s","start":"2026-03-30T23:48:22.725867Z","end":"2026-03-30T23:48:24.698005Z","steps":["trace[1671347627] 'agreement among raft nodes before linearized reading' (duration: 1.97209245s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:24.698026Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:22.725851Z","time spent":"1.972171421s","remote":"127.0.0.1:55176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:24.698296Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.920695962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:24.698327Z","caller":"traceutil/trace.go:172","msg":"trace[915216947] range","detail":"{range_begin:/registry/runtimeclasses; range_end:; response_count:0; response_revision:1006; }","duration":"1.920719812s","start":"2026-03-30T23:48:22.777593Z","end":"2026-03-30T23:48:24.698313Z","steps":["trace[915216947] 'agreement among raft nodes before linearized reading' (duration: 1.920682232s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:24.698381Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:22.777569Z","time spent":"1.920807574s","remote":"127.0.0.1:55080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:24.747569Z","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":725815393073706734,"received-request-id":725815393073706732} {"level":"info","ts":"2026-03-30T23:48:24.748119Z","caller":"traceutil/trace.go:172","msg":"trace[74929790] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1009; }","duration":"785.119396ms","start":"2026-03-30T23:48:23.962960Z","end":"2026-03-30T23:48:24.748080Z","steps":["trace[74929790] 'process raft request' (duration: 784.719776ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:24.748551Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:23.962932Z","time spent":"785.316741ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97,"response count":0,"response size":151272,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:24.888784Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"997.96491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:24.888778Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.004941393s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:24.888877Z","caller":"traceutil/trace.go:172","msg":"trace[1957394493] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:1013; }","duration":"998.081133ms","start":"2026-03-30T23:48:23.890774Z","end":"2026-03-30T23:48:24.888855Z","steps":["trace[1957394493] 'agreement among raft nodes before linearized reading' (duration: 997.909659ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:24.888889Z","caller":"traceutil/trace.go:172","msg":"trace[793650939] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1013; }","duration":"1.005094477s","start":"2026-03-30T23:48:23.883773Z","end":"2026-03-30T23:48:24.888868Z","steps":["trace[793650939] 'agreement among raft nodes before linearized reading' (duration: 1.004926544s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:24.888868Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"838.34239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:24.888938Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:23.890756Z","time spent":"998.159236ms","remote":"127.0.0.1:55170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":33,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:24.888949Z","caller":"traceutil/trace.go:172","msg":"trace[1577357303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1013; }","duration":"838.445163ms","start":"2026-03-30T23:48:24.050486Z","end":"2026-03-30T23:48:24.888931Z","steps":["trace[1577357303] 'agreement among raft nodes before linearized reading' (duration: 838.273878ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:24.888992Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:24.050458Z","time spent":"838.526926ms","remote":"127.0.0.1:32988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T23:48:24.889993Z","caller":"traceutil/trace.go:172","msg":"trace[192480049] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1017; }","duration":"147.074165ms","start":"2026-03-30T23:48:24.742903Z","end":"2026-03-30T23:48:24.889977Z","steps":["trace[192480049] 'process raft request' (duration: 146.622275ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:24.890372Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.097563991s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:24.890449Z","caller":"traceutil/trace.go:172","msg":"trace[959396378] range","detail":"{range_begin:/registry/deployments; range_end:; response_count:0; response_revision:1017; }","duration":"1.097649493s","start":"2026-03-30T23:48:23.792784Z","end":"2026-03-30T23:48:24.890434Z","steps":["trace[959396378] 'agreement among raft nodes before linearized reading' (duration: 1.09752849s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:24.888686Z","caller":"traceutil/trace.go:172","msg":"trace[1400353429] linearizableReadLoop","detail":"{readStateIndex:1151; appliedIndex:1151; }","duration":"190.843444ms","start":"2026-03-30T23:48:24.697799Z","end":"2026-03-30T23:48:24.888642Z","steps":["trace[1400353429] 'read index received' (duration: 190.826384ms)","trace[1400353429] 'applied index is now lower than readState.Index' (duration: 14.83µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:24.890501Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:23.792758Z","time spent":"1.097729626s","remote":"127.0.0.1:55318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":28,"request content":"key:\"/registry/deployments\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:25.379922Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"188.15387ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-03-30T23:48:25.391013Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706737,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:25.891920Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706737,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T23:48:26.145460Z","caller":"traceutil/trace.go:172","msg":"trace[883795176] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1168; }","duration":"1.254936135s","start":"2026-03-30T23:48:24.890498Z","end":"2026-03-30T23:48:26.145434Z","steps":["trace[883795176] 'read index received' (duration: 1.254927925s)","trace[883795176] 'applied index is now lower than readState.Index' (duration: 6.65µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:26.145744Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.25552601s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:26.145740Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.255246564s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:26.145810Z","caller":"traceutil/trace.go:172","msg":"trace[1227838446] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1024; }","duration":"1.255601792s","start":"2026-03-30T23:48:24.890192Z","end":"2026-03-30T23:48:26.145794Z","steps":["trace[1227838446] 'agreement among raft nodes before linearized reading' (duration: 1.25548856s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:26.145837Z","caller":"traceutil/trace.go:172","msg":"trace[507758785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1024; }","duration":"1.255380197s","start":"2026-03-30T23:48:24.890443Z","end":"2026-03-30T23:48:26.145823Z","steps":["trace[507758785] 'agreement among raft nodes before linearized reading' (duration: 1.255204242s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:26.146000Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:24.890420Z","time spent":"1.25556381s","remote":"127.0.0.1:32980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T23:48:26.146136Z","caller":"traceutil/trace.go:172","msg":"trace[1961416736] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"717.48279ms","start":"2026-03-30T23:48:25.428634Z","end":"2026-03-30T23:48:26.146116Z","steps":["trace[1961416736] 'process raft request' (duration: 717.394987ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:26.146226Z","caller":"traceutil/trace.go:172","msg":"trace[130040849] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1024; }","duration":"1.156221098s","start":"2026-03-30T23:48:24.989986Z","end":"2026-03-30T23:48:26.146207Z","steps":["trace[130040849] 'process raft request' (duration: 1.155706097s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:26.146270Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:25.428611Z","time spent":"717.592142ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:26.146350Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:24.989961Z","time spent":"1.1563101s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":98749,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:26.219178Z","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":725815393073706740,"received-request-id":725815393073706737} {"level":"info","ts":"2026-03-30T23:48:26.263226Z","caller":"traceutil/trace.go:172","msg":"trace[1496910584] linearizableReadLoop","detail":"{readStateIndex:1177; appliedIndex:1179; }","duration":"117.664824ms","start":"2026-03-30T23:48:26.145541Z","end":"2026-03-30T23:48:26.263205Z","steps":["trace[1496910584] 'read index received' (duration: 117.656103ms)","trace[1496910584] 'applied index is now lower than readState.Index' (duration: 7.391µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:26.263366Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.145828461s","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-03-30T23:48:26.263385Z","caller":"traceutil/trace.go:172","msg":"trace[1482006895] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1032; }","duration":"1.145867132s","start":"2026-03-30T23:48:25.117512Z","end":"2026-03-30T23:48:26.263379Z","steps":["trace[1482006895] 'agreement among raft nodes before linearized reading' (duration: 1.145781431s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:26.263405Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:25.117457Z","time spent":"1.145943515s","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:26.263484Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.134003298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-30T23:48:26.263560Z","caller":"traceutil/trace.go:172","msg":"trace[59960688] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:1032; }","duration":"1.13409617s","start":"2026-03-30T23:48:25.129447Z","end":"2026-03-30T23:48:26.263544Z","steps":["trace[59960688] 'agreement among raft nodes before linearized reading' (duration: 1.133859215s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:26.263597Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:25.129423Z","time spent":"1.134165172s","remote":"127.0.0.1:54518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.157\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:26.263607Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"450.160512ms","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-03-30T23:48:26.263617Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.326347372s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" limit:1 ","response":"range_response_count:1 size:98713"} {"level":"info","ts":"2026-03-30T23:48:26.263676Z","caller":"traceutil/trace.go:172","msg":"trace[746235275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1032; }","duration":"450.242664ms","start":"2026-03-30T23:48:25.813420Z","end":"2026-03-30T23:48:26.263663Z","steps":["trace[746235275] 'agreement among raft nodes before linearized reading' (duration: 450.023469ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:26.263693Z","caller":"traceutil/trace.go:172","msg":"trace[1009064897] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:1032; }","duration":"1.326443334s","start":"2026-03-30T23:48:24.937234Z","end":"2026-03-30T23:48:26.263677Z","steps":["trace[1009064897] 'agreement among raft nodes before linearized reading' (duration: 1.326157218s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:26.263708Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:25.813391Z","time spent":"450.310195ms","remote":"127.0.0.1:54926","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-03-30T23:48:26.263740Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:24.937215Z","time spent":"1.326515567s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":1,"response size":98736,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:26.264603Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.731922ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:26.264655Z","caller":"traceutil/trace.go:172","msg":"trace[430059761] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1032; }","duration":"116.785892ms","start":"2026-03-30T23:48:26.147855Z","end":"2026-03-30T23:48:26.264641Z","steps":["trace[430059761] 'agreement among raft nodes before linearized reading' (duration: 116.70007ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:26.264699Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.847997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:26.264737Z","caller":"traceutil/trace.go:172","msg":"trace[259807206] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1032; }","duration":"110.885838ms","start":"2026-03-30T23:48:26.153846Z","end":"2026-03-30T23:48:26.264731Z","steps":["trace[259807206] 'agreement among raft nodes before linearized reading' (duration: 110.832837ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:26.265535Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.160959473s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-30T23:48:26.265607Z","caller":"traceutil/trace.go:172","msg":"trace[1093424649] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:1032; }","duration":"1.161029414s","start":"2026-03-30T23:48:25.104559Z","end":"2026-03-30T23:48:26.265588Z","steps":["trace[1093424649] 'agreement among raft nodes before linearized reading' (duration: 1.158737702s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:26.265707Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:25.104543Z","time spent":"1.161095095s","remote":"127.0.0.1:54638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:26.747605Z","caller":"traceutil/trace.go:172","msg":"trace[658411638] linearizableReadLoop","detail":"{readStateIndex:1185; appliedIndex:1185; }","duration":"356.578963ms","start":"2026-03-30T23:48:26.391006Z","end":"2026-03-30T23:48:26.747585Z","steps":["trace[658411638] 'read index received' (duration: 356.573183ms)","trace[658411638] 'applied index is now lower than readState.Index' (duration: 4.32µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:27.241864Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"850.839585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:101 size:8589"} {"level":"info","ts":"2026-03-30T23:48:27.241967Z","caller":"traceutil/trace.go:172","msg":"trace[1828678669] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:101; response_revision:1034; }","duration":"850.950477ms","start":"2026-03-30T23:48:26.390997Z","end":"2026-03-30T23:48:27.241947Z","steps":["trace[1828678669] 'agreement among raft nodes before linearized reading' (duration: 356.733997ms)","trace[1828678669] 'range keys from in-memory index tree' (duration: 493.592506ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:27.242009Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:26.390976Z","time spent":"851.020658ms","remote":"127.0.0.1:55482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":101,"response size":8612,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true "} {"level":"warn","ts":"2026-03-30T23:48:27.248835Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706754,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T23:48:27.335173Z","caller":"traceutil/trace.go:172","msg":"trace[601629090] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1034; }","duration":"915.085095ms","start":"2026-03-30T23:48:26.420054Z","end":"2026-03-30T23:48:27.335139Z","steps":["trace[601629090] 'process raft request' (duration: 914.242766ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:27.335332Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:26.420027Z","time spent":"915.224417ms","remote":"127.0.0.1:54556","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-03-30T23:48:27.622434Z","caller":"traceutil/trace.go:172","msg":"trace[1331795078] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1036; }","duration":"1.015286964s","start":"2026-03-30T23:48:26.607122Z","end":"2026-03-30T23:48:27.622409Z","steps":["trace[1331795078] 'process raft request' (duration: 1.014948607s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:27.622686Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:26.607097Z","time spent":"1.015502629s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":95,"response count":0,"response size":570141,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:27.749525Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706754,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T23:48:27.882926Z","caller":"traceutil/trace.go:172","msg":"trace[970128967] linearizableReadLoop","detail":"{readStateIndex:1191; appliedIndex:1195; }","duration":"1.13516995s","start":"2026-03-30T23:48:26.747721Z","end":"2026-03-30T23:48:27.882891Z","steps":["trace[970128967] 'read index received' (duration: 1.135156968s)","trace[970128967] 'applied index is now lower than readState.Index' (duration: 11.161µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:28.051231Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.426543514s","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-03-30T23:48:28.051373Z","caller":"traceutil/trace.go:172","msg":"trace[1050269935] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1040; }","duration":"1.426675868s","start":"2026-03-30T23:48:26.624651Z","end":"2026-03-30T23:48:28.051327Z","steps":["trace[1050269935] 'agreement among raft nodes before linearized reading' (duration: 1.258243248s)","trace[1050269935] 'range keys from in-memory index tree' (duration: 168.123003ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:28.051423Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:26.624633Z","time spent":"1.42677614s","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:28.051612Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.550183076s","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":"warn","ts":"2026-03-30T23:48:28.051540Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.653634032s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:28.051694Z","caller":"traceutil/trace.go:172","msg":"trace[709422941] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1040; }","duration":"1.550485163s","start":"2026-03-30T23:48:26.501189Z","end":"2026-03-30T23:48:28.051674Z","steps":["trace[709422941] 'agreement among raft nodes before linearized reading' (duration: 1.381746595s)","trace[709422941] 'range keys from in-memory index tree' (duration: 168.262558ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:28.051736Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:26.501173Z","time spent":"1.550554313s","remote":"127.0.0.1:54926","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":"info","ts":"2026-03-30T23:48:28.051713Z","caller":"traceutil/trace.go:172","msg":"trace[1784794212] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1040; }","duration":"1.653881767s","start":"2026-03-30T23:48:26.397808Z","end":"2026-03-30T23:48:28.051690Z","steps":["trace[1784794212] 'agreement among raft nodes before linearized reading' (duration: 1.485245412s)","trace[1784794212] 'range keys from in-memory index tree' (duration: 168.351178ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T23:48:28.054184Z","caller":"traceutil/trace.go:172","msg":"trace[1092085365] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1040; }","duration":"555.3743ms","start":"2026-03-30T23:48:27.498777Z","end":"2026-03-30T23:48:28.054152Z","steps":["trace[1092085365] 'process raft request' (duration: 555.144665ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:28.054409Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:27.498746Z","time spent":"555.524244ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":99,"response count":0,"response size":208512,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:28.093570Z","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":725815393073706757,"received-request-id":725815393073706754} {"level":"info","ts":"2026-03-30T23:48:28.093762Z","caller":"traceutil/trace.go:172","msg":"trace[354313704] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1044; }","duration":"323.494594ms","start":"2026-03-30T23:48:27.770248Z","end":"2026-03-30T23:48:28.093743Z","steps":["trace[354313704] 'process raft request' (duration: 323.389382ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:28.093924Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:27.770209Z","time spent":"323.649888ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":99,"response count":0,"response size":208521,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T23:48:28.096618Z","caller":"traceutil/trace.go:172","msg":"trace[1622745836] linearizableReadLoop","detail":"{readStateIndex:1202; appliedIndex:1203; }","duration":"213.567342ms","start":"2026-03-30T23:48:27.883031Z","end":"2026-03-30T23:48:28.096598Z","steps":["trace[1622745836] 'read index received' (duration: 213.560862ms)","trace[1622745836] 'applied index is now lower than readState.Index' (duration: 5.37µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:28.096807Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.30148252s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:28.096833Z","caller":"traceutil/trace.go:172","msg":"trace[1499982708] range","detail":"{range_begin:/registry/persistentvolumeclaims; range_end:; response_count:0; response_revision:1044; }","duration":"1.301528561s","start":"2026-03-30T23:48:26.795295Z","end":"2026-03-30T23:48:28.096824Z","steps":["trace[1499982708] 'agreement among raft nodes before linearized reading' (duration: 1.301444279s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:28.096858Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:26.795277Z","time spent":"1.301575513s","remote":"127.0.0.1:54750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:28.096854Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"317.641151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:28.096910Z","caller":"traceutil/trace.go:172","msg":"trace[1345281326] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions; range_end:; response_count:0; response_revision:1044; }","duration":"317.731203ms","start":"2026-03-30T23:48:27.779163Z","end":"2026-03-30T23:48:28.096894Z","steps":["trace[1345281326] 'agreement among raft nodes before linearized reading' (duration: 317.553918ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:28.096950Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:27.779135Z","time spent":"317.806033ms","remote":"127.0.0.1:54556","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":"warn","ts":"2026-03-30T23:48:28.097484Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"215.195939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:103 size:8789"} {"level":"info","ts":"2026-03-30T23:48:28.098384Z","caller":"traceutil/trace.go:172","msg":"trace[1259980587] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:103; response_revision:1045; }","duration":"216.086389ms","start":"2026-03-30T23:48:27.882270Z","end":"2026-03-30T23:48:28.098357Z","steps":["trace[1259980587] 'agreement among raft nodes before linearized reading' (duration: 214.515023ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:31.896350Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706778,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:32.396943Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706778,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T23:48:32.446476Z","caller":"traceutil/trace.go:172","msg":"trace[762405755] linearizableReadLoop","detail":"{readStateIndex:1246; appliedIndex:1246; }","duration":"1.050369809s","start":"2026-03-30T23:48:31.396091Z","end":"2026-03-30T23:48:32.446461Z","steps":["trace[762405755] 'read index received' (duration: 1.050364559s)","trace[762405755] 'applied index is now lower than readState.Index' (duration: 4.33µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:32.446585Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.050481022s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:32.446625Z","caller":"traceutil/trace.go:172","msg":"trace[1557768938] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1084; }","duration":"1.050536593s","start":"2026-03-30T23:48:31.396083Z","end":"2026-03-30T23:48:32.446620Z","steps":["trace[1557768938] 'agreement among raft nodes before linearized reading' (duration: 1.050461672s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:32.446995Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:31.374182Z","time spent":"1.072811925s","remote":"127.0.0.1:54580","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-03-30T23:48:32.481715Z","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":725815393073706781,"received-request-id":725815393073706778} {"level":"warn","ts":"2026-03-30T23:48:32.525386Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"724.730114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:32.525402Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"439.222161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:32.525475Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"475.434812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:32.525480Z","caller":"traceutil/trace.go:172","msg":"trace[1809093939] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:1088; }","duration":"724.838566ms","start":"2026-03-30T23:48:31.800620Z","end":"2026-03-30T23:48:32.525458Z","steps":["trace[1809093939] 'agreement among raft nodes before linearized reading' (duration: 724.672713ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:32.525496Z","caller":"traceutil/trace.go:172","msg":"trace[868380631] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:1088; }","duration":"439.333513ms","start":"2026-03-30T23:48:32.086142Z","end":"2026-03-30T23:48:32.525476Z","steps":["trace[868380631] 'agreement among raft nodes before linearized reading' (duration: 439.17174ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:32.525523Z","caller":"traceutil/trace.go:172","msg":"trace[62253227] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1088; }","duration":"475.468514ms","start":"2026-03-30T23:48:32.050034Z","end":"2026-03-30T23:48:32.525503Z","steps":["trace[62253227] 'agreement among raft nodes before linearized reading' (duration: 475.420632ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:32.525540Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:32.086121Z","time spent":"439.409635ms","remote":"127.0.0.1:54718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:32.525407Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"622.891791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-03-30T23:48:32.525560Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:32.050014Z","time spent":"475.538754ms","remote":"127.0.0.1:32988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T23:48:32.525583Z","caller":"traceutil/trace.go:172","msg":"trace[264360102] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:1088; }","duration":"623.080304ms","start":"2026-03-30T23:48:31.902490Z","end":"2026-03-30T23:48:32.525570Z","steps":["trace[264360102] 'agreement among raft nodes before linearized reading' (duration: 622.742887ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:32.525564Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"687.616398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:32.525536Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:31.800607Z","time spent":"724.916358ms","remote":"127.0.0.1:54718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:32.525620Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:31.902468Z","time spent":"623.142207ms","remote":"127.0.0.1:54638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:32.525642Z","caller":"traceutil/trace.go:172","msg":"trace[1179163305] range","detail":"{range_begin:/registry/resourceslices; range_end:; response_count:0; response_revision:1088; }","duration":"687.70037ms","start":"2026-03-30T23:48:31.837923Z","end":"2026-03-30T23:48:32.525624Z","steps":["trace[1179163305] 'agreement among raft nodes before linearized reading' (duration: 687.493315ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:32.525594Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"812.42629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-03-30T23:48:32.525686Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:31.837907Z","time spent":"687.767821ms","remote":"127.0.0.1:55548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/resourceslices\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:32.525709Z","caller":"traceutil/trace.go:172","msg":"trace[2030041184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1088; }","duration":"812.542703ms","start":"2026-03-30T23:48:31.713137Z","end":"2026-03-30T23:48:32.525680Z","steps":["trace[2030041184] 'agreement among raft nodes before linearized reading' (duration: 812.236116ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:32.525781Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:31.713111Z","time spent":"812.650625ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:33.025759Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706783,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:33.526441Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706783,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:34.027073Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706783,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T23:48:34.492085Z","caller":"traceutil/trace.go:172","msg":"trace[388567868] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1254; }","duration":"1.966889225s","start":"2026-03-30T23:48:32.525171Z","end":"2026-03-30T23:48:34.492060Z","steps":["trace[388567868] 'read index received' (duration: 1.966866365s)","trace[388567868] 'applied index is now lower than readState.Index' (duration: 21.57µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:34.492506Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.044663399s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:34.492603Z","caller":"traceutil/trace.go:172","msg":"trace[2048916537] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1091; }","duration":"2.044793572s","start":"2026-03-30T23:48:32.447795Z","end":"2026-03-30T23:48:34.492589Z","steps":["trace[2048916537] 'agreement among raft nodes before linearized reading' (duration: 2.044622078s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:34.493365Z","caller":"traceutil/trace.go:172","msg":"trace[1560638360] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"1.963810557s","start":"2026-03-30T23:48:32.529536Z","end":"2026-03-30T23:48:34.493347Z","steps":["trace[1560638360] 'process raft request' (duration: 1.963102671s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:34.493489Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:32.529520Z","time spent":"1.963909899s","remote":"127.0.0.1:54580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":697,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T23:48:34.527860Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000486481s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-03-30T23:48:34.527964Z","caller":"traceutil/trace.go:172","msg":"trace[797167955] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000603683s","start":"2026-03-30T23:48:32.527343Z","end":"2026-03-30T23:48:34.527947Z","steps":["trace[797167955] 'agreement among raft nodes before linearized reading' (duration: 2.000464351s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:34.528015Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:32.527326Z","time spent":"2.000680336s","remote":"127.0.0.1:32980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/03/30 23:48:34 WARNING: [core] [Server #6]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-03-30T23:48:34.611550Z","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":725815393073706785,"received-request-id":725815393073706783} {"level":"info","ts":"2026-03-30T23:48:34.618941Z","caller":"traceutil/trace.go:172","msg":"trace[1162288251] linearizableReadLoop","detail":"{readStateIndex:1260; appliedIndex:1260; }","duration":"126.773818ms","start":"2026-03-30T23:48:34.492148Z","end":"2026-03-30T23:48:34.618921Z","steps":["trace[1162288251] 'read index received' (duration: 126.765348ms)","trace[1162288251] 'applied index is now lower than readState.Index' (duration: 7.16µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:34.619270Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"404.213454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceclaims\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:34.619748Z","caller":"traceutil/trace.go:172","msg":"trace[351369003] range","detail":"{range_begin:/registry/resourceclaims; range_end:; response_count:0; response_revision:1097; }","duration":"404.697155ms","start":"2026-03-30T23:48:34.215032Z","end":"2026-03-30T23:48:34.619729Z","steps":["trace[351369003] 'agreement among raft nodes before linearized reading' (duration: 404.178334ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:34.619833Z","caller":"traceutil/trace.go:172","msg":"trace[636488791] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"121.371509ms","start":"2026-03-30T23:48:34.498446Z","end":"2026-03-30T23:48:34.619817Z","steps":["trace[636488791] 'process raft request' (duration: 121.188264ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:34.619370Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.532406654s","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-03-30T23:48:34.620126Z","caller":"traceutil/trace.go:172","msg":"trace[935830531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1097; }","duration":"1.533124631s","start":"2026-03-30T23:48:33.086926Z","end":"2026-03-30T23:48:34.620051Z","steps":["trace[935830531] 'agreement among raft nodes before linearized reading' (duration: 1.532288372s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:34.619857Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.215009Z","time spent":"404.833739ms","remote":"127.0.0.1:55506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/resourceclaims\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:34.620213Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:33.086905Z","time spent":"1.533284874s","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:34.619394Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.968514777s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5vltn\" limit:1 ","response":"range_response_count:1 size:18354"} {"level":"info","ts":"2026-03-30T23:48:34.620375Z","caller":"traceutil/trace.go:172","msg":"trace[318884379] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5vltn; range_end:; response_count:1; response_revision:1097; }","duration":"1.9695128s","start":"2026-03-30T23:48:32.650848Z","end":"2026-03-30T23:48:34.620361Z","steps":["trace[318884379] 'agreement among raft nodes before linearized reading' (duration: 1.968290202s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:34.620484Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:32.650829Z","time spent":"1.969639053s","remote":"127.0.0.1:54800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18377,"request content":"key:\"/registry/pods/kube-system/cilium-5vltn\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:34.619518Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.088242993s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" limit:1 ","response":"range_response_count:1 size:6534"} {"level":"info","ts":"2026-03-30T23:48:34.620710Z","caller":"traceutil/trace.go:172","msg":"trace[1026585235] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:1097; }","duration":"2.089425439s","start":"2026-03-30T23:48:32.531265Z","end":"2026-03-30T23:48:34.620690Z","steps":["trace[1026585235] 'agreement among raft nodes before linearized reading' (duration: 2.088169141s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:34.620764Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:32.531255Z","time spent":"2.08949487s","remote":"127.0.0.1:54634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":6557,"request content":"key:\"/registry/configmaps/kube-system/cilium-config\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:34.619535Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.027545172s","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-03-30T23:48:34.620916Z","caller":"traceutil/trace.go:172","msg":"trace[158227509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1097; }","duration":"1.028920194s","start":"2026-03-30T23:48:33.591978Z","end":"2026-03-30T23:48:34.620898Z","steps":["trace[158227509] 'agreement among raft nodes before linearized reading' (duration: 1.026983291s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:34.620982Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:33.591944Z","time spent":"1.029020065s","remote":"127.0.0.1:54926","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":"warn","ts":"2026-03-30T23:48:34.619370Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.168494049s","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-03-30T23:48:34.621041Z","caller":"traceutil/trace.go:172","msg":"trace[1591085630] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1097; }","duration":"1.170183127s","start":"2026-03-30T23:48:33.450847Z","end":"2026-03-30T23:48:34.621030Z","steps":["trace[1591085630] 'agreement among raft nodes before linearized reading' (duration: 1.168163972s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:34.621085Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:33.450824Z","time spent":"1.170249138s","remote":"127.0.0.1:54926","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-03-30T23:48:34.622977Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.00210763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:124 size:10509"} {"level":"info","ts":"2026-03-30T23:48:34.623070Z","caller":"traceutil/trace.go:172","msg":"trace[1030931220] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:124; response_revision:1097; }","duration":"2.002205243s","start":"2026-03-30T23:48:32.620849Z","end":"2026-03-30T23:48:34.623054Z","steps":["trace[1030931220] 'agreement among raft nodes before linearized reading' (duration: 1.99850317s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:34.623112Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:32.620833Z","time spent":"2.002263253s","remote":"127.0.0.1:54580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":124,"response size":10532,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true "} {"level":"warn","ts":"2026-03-30T23:48:34.634078Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"138.656272ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:34.634166Z","caller":"traceutil/trace.go:172","msg":"trace[1044972119] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1104; }","duration":"138.802336ms","start":"2026-03-30T23:48:34.495344Z","end":"2026-03-30T23:48:34.634147Z","steps":["trace[1044972119] 'agreement among raft nodes before linearized reading' (duration: 138.583791ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:35.135650Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706789,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:35.636053Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706789,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:35.802941Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.065508565s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T23:48:35.803998Z","caller":"traceutil/trace.go:172","msg":"trace[349552899] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1270; }","duration":"1.168768442s","start":"2026-03-30T23:48:34.635203Z","end":"2026-03-30T23:48:35.803972Z","steps":["trace[349552899] 'read index received' (duration: 1.168759402s)","trace[349552899] 'applied index is now lower than readState.Index' (duration: 7.6µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:35.804172Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.168947546s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:35.804204Z","caller":"traceutil/trace.go:172","msg":"trace[1427077290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1106; }","duration":"1.168993857s","start":"2026-03-30T23:48:34.635200Z","end":"2026-03-30T23:48:35.804194Z","steps":["trace[1427077290] 'agreement among raft nodes before linearized reading' (duration: 1.168902095s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:35.804238Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.635189Z","time spent":"1.169042867s","remote":"127.0.0.1:32980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T23:48:35.804599Z","caller":"traceutil/trace.go:172","msg":"trace[1576040487] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"1.165658603s","start":"2026-03-30T23:48:34.638923Z","end":"2026-03-30T23:48:35.804582Z","steps":["trace[1576040487] 'process raft request' (duration: 1.165216343s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:35.806469Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.638913Z","time spent":"1.167439661s","remote":"127.0.0.1:54800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:36.137692Z","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":725815393073706791,"received-request-id":725815393073706789} {"level":"info","ts":"2026-03-30T23:48:36.140645Z","caller":"traceutil/trace.go:172","msg":"trace[2130668246] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1298; }","duration":"336.542995ms","start":"2026-03-30T23:48:35.804073Z","end":"2026-03-30T23:48:36.140616Z","steps":["trace[2130668246] 'read index received' (duration: 336.530135ms)","trace[2130668246] 'applied index is now lower than readState.Index' (duration: 11.65µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:48:36.140986Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.304112175s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:36.141036Z","caller":"traceutil/trace.go:172","msg":"trace[1721342595] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.304178996s","start":"2026-03-30T23:48:34.836841Z","end":"2026-03-30T23:48:36.141020Z","steps":["trace[1721342595] 'agreement among raft nodes before linearized reading' (duration: 1.304023292s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.141109Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.836808Z","time spent":"1.304287708s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.141108Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"476.615034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:36.141356Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"817.240344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:36.141496Z","caller":"traceutil/trace.go:172","msg":"trace[1975164106] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices; range_end:; response_count:0; response_revision:1133; }","duration":"476.850199ms","start":"2026-03-30T23:48:35.664465Z","end":"2026-03-30T23:48:36.141315Z","steps":["trace[1975164106] 'agreement among raft nodes before linearized reading' (duration: 476.538723ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.141472Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.0113848s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-03-30T23:48:36.141509Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.504780865s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:36.141598Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"739.81643ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:36.141630Z","caller":"traceutil/trace.go:172","msg":"trace[250420124] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.504935508s","start":"2026-03-30T23:48:34.636672Z","end":"2026-03-30T23:48:36.141607Z","steps":["trace[250420124] 'agreement among raft nodes before linearized reading' (duration: 1.504688863s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:36.141640Z","caller":"traceutil/trace.go:172","msg":"trace[625088269] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:1133; }","duration":"1.011490332s","start":"2026-03-30T23:48:35.130069Z","end":"2026-03-30T23:48:36.141560Z","steps":["trace[625088269] 'agreement among raft nodes before linearized reading' (duration: 1.010547391s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:36.141645Z","caller":"traceutil/trace.go:172","msg":"trace[1265498646] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1133; }","duration":"739.868571ms","start":"2026-03-30T23:48:35.401762Z","end":"2026-03-30T23:48:36.141631Z","steps":["trace[1265498646] 'agreement among raft nodes before linearized reading' (duration: 739.79789ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.141653Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"955.738158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-03-30T23:48:36.141684Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.636665Z","time spent":"1.50500989s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:36.141716Z","caller":"traceutil/trace.go:172","msg":"trace[940672365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1133; }","duration":"955.80422ms","start":"2026-03-30T23:48:35.185896Z","end":"2026-03-30T23:48:36.141701Z","steps":["trace[940672365] 'agreement among raft nodes before linearized reading' (duration: 955.544775ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.141749Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.492380339s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:36.141759Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:35.185875Z","time spent":"955.872721ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:36.141790Z","caller":"traceutil/trace.go:172","msg":"trace[1230672404] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.4924095s","start":"2026-03-30T23:48:34.649363Z","end":"2026-03-30T23:48:36.141773Z","steps":["trace[1230672404] 'agreement among raft nodes before linearized reading' (duration: 1.492373928s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.141814Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:35.130051Z","time spent":"1.011620306s","remote":"127.0.0.1:54518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.157\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.141833Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.649331Z","time spent":"1.492495111s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.141958Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.504457126s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:36.142014Z","caller":"traceutil/trace.go:172","msg":"trace[279798481] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.504510928s","start":"2026-03-30T23:48:34.637491Z","end":"2026-03-30T23:48:36.142001Z","steps":["trace[279798481] 'agreement among raft nodes before linearized reading' (duration: 1.504428666s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.142070Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.637485Z","time spent":"1.504562738s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.141759Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:35.664441Z","time spent":"477.299561ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.142243Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.505205614s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:36.142283Z","caller":"traceutil/trace.go:172","msg":"trace[586845944] range","detail":"{range_begin:/registry/priorityclasses; range_end:; response_count:0; response_revision:1133; }","duration":"817.352247ms","start":"2026-03-30T23:48:35.324077Z","end":"2026-03-30T23:48:36.141429Z","steps":["trace[586845944] 'agreement among raft nodes before linearized reading' (duration: 817.160252ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:36.142293Z","caller":"traceutil/trace.go:172","msg":"trace[2084301228] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.505254894s","start":"2026-03-30T23:48:34.637023Z","end":"2026-03-30T23:48:36.142278Z","steps":["trace[2084301228] 'agreement among raft nodes before linearized reading' (duration: 1.505124772s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.142344Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.637016Z","time spent":"1.505319387s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.142344Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:35.324049Z","time spent":"818.282076ms","remote":"127.0.0.1:55176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.141720Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.466287369s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:36.142405Z","caller":"traceutil/trace.go:172","msg":"trace[1168118982] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.466974495s","start":"2026-03-30T23:48:34.675420Z","end":"2026-03-30T23:48:36.142395Z","steps":["trace[1168118982] 'agreement among raft nodes before linearized reading' (duration: 1.466271969s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.141053Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.502424262s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:36.142459Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.675392Z","time spent":"1.467033505s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:36.142462Z","caller":"traceutil/trace.go:172","msg":"trace[316177724] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.503851334s","start":"2026-03-30T23:48:34.638599Z","end":"2026-03-30T23:48:36.142450Z","steps":["trace[316177724] 'agreement among raft nodes before linearized reading' (duration: 1.50234834s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.142506Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.638594Z","time spent":"1.503895994s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.142514Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.501797568s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:36.142599Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.502108165s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:36.142866Z","caller":"traceutil/trace.go:172","msg":"trace[557513141] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.502370702s","start":"2026-03-30T23:48:34.640483Z","end":"2026-03-30T23:48:36.142854Z","steps":["trace[557513141] 'agreement among raft nodes before linearized reading' (duration: 1.502086315s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.142014Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.506353849s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:36.143081Z","caller":"traceutil/trace.go:172","msg":"trace[1217881219] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.507412312s","start":"2026-03-30T23:48:34.635654Z","end":"2026-03-30T23:48:36.143066Z","steps":["trace[1217881219] 'agreement among raft nodes before linearized reading' (duration: 1.506342259s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.143131Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.635648Z","time spent":"1.507469023s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.141969Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.505646603s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:36.142762Z","caller":"traceutil/trace.go:172","msg":"trace[901297484] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.501826809s","start":"2026-03-30T23:48:34.640709Z","end":"2026-03-30T23:48:36.142535Z","steps":["trace[901297484] 'agreement among raft nodes before linearized reading' (duration: 1.501780267s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.143378Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.640703Z","time spent":"1.502656537s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:36.143434Z","caller":"traceutil/trace.go:172","msg":"trace[1408390976] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:1133; }","duration":"1.506864411s","start":"2026-03-30T23:48:34.636308Z","end":"2026-03-30T23:48:36.143173Z","steps":["trace[1408390976] 'agreement among raft nodes before linearized reading' (duration: 1.505619653s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.143477Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.636292Z","time spent":"1.507172827s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.143883Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"325.535252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:36.144463Z","caller":"traceutil/trace.go:172","msg":"trace[222928486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1133; }","duration":"326.111505ms","start":"2026-03-30T23:48:35.818336Z","end":"2026-03-30T23:48:36.144447Z","steps":["trace[222928486] 'agreement among raft nodes before linearized reading' (duration: 325.507581ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:36.144704Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:35.818319Z","time spent":"326.34659ms","remote":"127.0.0.1:32988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T23:48:36.144294Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:34.640476Z","time spent":"1.503804573s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:36.673288Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706801,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:37.174247Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706801,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T23:48:37.641396Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.486483337s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T23:48:37.642548Z","caller":"traceutil/trace.go:172","msg":"trace[1468093014] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"1.490553888s","start":"2026-03-30T23:48:36.151931Z","end":"2026-03-30T23:48:37.642484Z","steps":["trace[1468093014] 'process raft request' (duration: 1.490184089s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:37.642602Z","caller":"traceutil/trace.go:172","msg":"trace[1786293610] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"1.491006906s","start":"2026-03-30T23:48:36.151556Z","end":"2026-03-30T23:48:37.642563Z","steps":["trace[1786293610] 'process raft request' (duration: 1.490323761s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:37.642650Z","caller":"traceutil/trace.go:172","msg":"trace[480840435] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"1.490535047s","start":"2026-03-30T23:48:36.152063Z","end":"2026-03-30T23:48:37.642598Z","steps":["trace[480840435] 'process raft request' (duration: 1.490122628s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:37.642706Z","caller":"traceutil/trace.go:172","msg":"trace[172120680] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"1.490840185s","start":"2026-03-30T23:48:36.151846Z","end":"2026-03-30T23:48:37.642686Z","steps":["trace[172120680] 'process raft request' (duration: 1.490232381s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:37.642713Z","caller":"traceutil/trace.go:172","msg":"trace[1795683379] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"1.49063329s","start":"2026-03-30T23:48:36.152055Z","end":"2026-03-30T23:48:37.642688Z","steps":["trace[1795683379] 'process raft request' (duration: 1.490092688s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:37.642808Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.151534Z","time spent":"1.491177502s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T23:48:37.642823Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.151834Z","time spent":"1.490919215s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T23:48:37.642823Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.152044Z","time spent":"1.490719011s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T23:48:37.642963Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.151914Z","time spent":"1.490721201s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T23:48:37.643532Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.152052Z","time spent":"1.491432947s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T23:48:37.675360Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073706801,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T23:48:38.072263Z","caller":"traceutil/trace.go:172","msg":"trace[648978832] linearizableReadLoop","detail":"{readStateIndex:1337; appliedIndex:1312; }","duration":"1.899089653s","start":"2026-03-30T23:48:36.173160Z","end":"2026-03-30T23:48:38.072250Z","steps":["trace[648978832] 'read index received' (duration: 1.898376128s)","trace[648978832] 'applied index is now lower than readState.Index' (duration: 713.025µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T23:48:38.072495Z","caller":"traceutil/trace.go:172","msg":"trace[1798054214] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"1.918659204s","start":"2026-03-30T23:48:36.153813Z","end":"2026-03-30T23:48:38.072472Z","steps":["trace[1798054214] 'process raft request' (duration: 1.918345167s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.072612Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.153800Z","time spent":"1.918751157s","remote":"127.0.0.1:54518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:38.073338Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.900170896s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:38.073386Z","caller":"traceutil/trace.go:172","msg":"trace[1866449642] range","detail":"{range_begin:/registry/persistentvolumes; range_end:; response_count:0; response_revision:1163; }","duration":"1.900218598s","start":"2026-03-30T23:48:36.173153Z","end":"2026-03-30T23:48:38.073372Z","steps":["trace[1866449642] 'agreement among raft nodes before linearized reading' (duration: 1.900140516s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.073412Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.173133Z","time spent":"1.900272698s","remote":"127.0.0.1:54722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:38.090616Z","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":725815393073706812,"received-request-id":725815393073706801} {"level":"info","ts":"2026-03-30T23:48:38.091097Z","caller":"traceutil/trace.go:172","msg":"trace[747735942] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"1.912535986s","start":"2026-03-30T23:48:36.178541Z","end":"2026-03-30T23:48:38.091077Z","steps":["trace[747735942] 'process raft request' (duration: 1.912343721s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.091260Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.178524Z","time spent":"1.912618477s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T23:48:38.091262Z","caller":"traceutil/trace.go:172","msg":"trace[429152459] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"1.584820445s","start":"2026-03-30T23:48:36.506420Z","end":"2026-03-30T23:48:38.091240Z","steps":["trace[429152459] 'process raft request' (duration: 1.584657501s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:38.091332Z","caller":"traceutil/trace.go:172","msg":"trace[1870221808] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"1.852122054s","start":"2026-03-30T23:48:36.239002Z","end":"2026-03-30T23:48:38.091124Z","steps":["trace[1870221808] 'process raft request' (duration: 1.852015812s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.091415Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.506389Z","time spent":"1.584951208s","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:38.091431Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.238969Z","time spent":"1.85240777s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T23:48:38.091478Z","caller":"traceutil/trace.go:172","msg":"trace[1576860920] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"1.414117832s","start":"2026-03-30T23:48:36.677337Z","end":"2026-03-30T23:48:38.091454Z","steps":["trace[1576860920] 'process raft request' (duration: 1.413845826s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:38.091580Z","caller":"traceutil/trace.go:172","msg":"trace[1368802086] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"1.249274051s","start":"2026-03-30T23:48:36.842279Z","end":"2026-03-30T23:48:38.091553Z","steps":["trace[1368802086] 'process raft request' (duration: 1.249103736s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:38.091253Z","caller":"traceutil/trace.go:172","msg":"trace[607302305] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"1.6522953s","start":"2026-03-30T23:48:36.438929Z","end":"2026-03-30T23:48:38.091224Z","steps":["trace[607302305] 'process raft request' (duration: 1.652121217s)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:38.091635Z","caller":"traceutil/trace.go:172","msg":"trace[1611182770] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"1.044749598s","start":"2026-03-30T23:48:37.046807Z","end":"2026-03-30T23:48:38.091557Z","steps":["trace[1611182770] 'process raft request' (duration: 1.044651755s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.091819Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:37.046775Z","time spent":"1.045020953s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T23:48:38.091834Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.438853Z","time spent":"1.652933055s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T23:48:38.091819Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.842246Z","time spent":"1.249473945s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T23:48:38.091939Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.677308Z","time spent":"1.414581443s","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T23:48:38.097921Z","caller":"traceutil/trace.go:172","msg":"trace[808506884] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1170; }","duration":"444.785421ms","start":"2026-03-30T23:48:37.653120Z","end":"2026-03-30T23:48:38.097906Z","steps":["trace[808506884] 'process raft request' (duration: 444.659279ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:38.097931Z","caller":"traceutil/trace.go:172","msg":"trace[1392869849] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1170; }","duration":"448.729647ms","start":"2026-03-30T23:48:37.649186Z","end":"2026-03-30T23:48:38.097916Z","steps":["trace[1392869849] 'process raft request' (duration: 448.495421ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.098102Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:37.649166Z","time spent":"448.896171ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":87,"response count":0,"response size":4367,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:38.098403Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:37.653096Z","time spent":"444.897863ms","remote":"127.0.0.1:54556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":87,"response count":0,"response size":4367,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T23:48:38.100384Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"351.609406ms","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-03-30T23:48:38.100442Z","caller":"traceutil/trace.go:172","msg":"trace[312134147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1171; }","duration":"351.676368ms","start":"2026-03-30T23:48:37.748753Z","end":"2026-03-30T23:48:38.100430Z","steps":["trace[312134147] 'agreement among raft nodes before linearized reading' (duration: 351.559196ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.100476Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:37.748732Z","time spent":"351.735158ms","remote":"127.0.0.1:54926","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-03-30T23:48:38.100732Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.370692714s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"warn","ts":"2026-03-30T23:48:38.100851Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"455.052056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v2alpha1.cilium.io\" limit:1 ","response":"range_response_count:1 size:965"} {"level":"info","ts":"2026-03-30T23:48:38.101356Z","caller":"traceutil/trace.go:172","msg":"trace[674239042] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v2alpha1.cilium.io; range_end:; response_count:1; response_revision:1171; }","duration":"455.551517ms","start":"2026-03-30T23:48:37.645791Z","end":"2026-03-30T23:48:38.101343Z","steps":["trace[674239042] 'agreement among raft nodes before linearized reading' (duration: 454.968404ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.101504Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:37.645768Z","time spent":"455.70554ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":988,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v2alpha1.cilium.io\" limit:1 "} {"level":"info","ts":"2026-03-30T23:48:38.101432Z","caller":"traceutil/trace.go:172","msg":"trace[1137292411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1171; }","duration":"1.371399919s","start":"2026-03-30T23:48:36.730024Z","end":"2026-03-30T23:48:38.101424Z","steps":["trace[1137292411] 'agreement among raft nodes before linearized reading' (duration: 1.370646662s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.101886Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.730010Z","time spent":"1.371864229s","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:38.100920Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"981.358884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicybindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:38.102123Z","caller":"traceutil/trace.go:172","msg":"trace[268917271] range","detail":"{range_begin:/registry/validatingadmissionpolicybindings; range_end:; response_count:0; response_revision:1171; }","duration":"982.53683ms","start":"2026-03-30T23:48:37.119555Z","end":"2026-03-30T23:48:38.102092Z","steps":["trace[268917271] 'agreement among raft nodes before linearized reading' (duration: 981.343724ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.102205Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:37.119539Z","time spent":"982.656072ms","remote":"127.0.0.1:55464","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":"warn","ts":"2026-03-30T23:48:38.100907Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.384517799s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:48:38.102507Z","caller":"traceutil/trace.go:172","msg":"trace[1893218270] range","detail":"{range_begin:/registry/csistoragecapacities; range_end:; response_count:0; response_revision:1171; }","duration":"1.386117284s","start":"2026-03-30T23:48:36.716377Z","end":"2026-03-30T23:48:38.102495Z","steps":["trace[1893218270] 'agreement among raft nodes before linearized reading' (duration: 1.384494349s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.100944Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.050089732s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:38.100971Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.704460729s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:38.100887Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"834.700786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:48:38.103605Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:36.716344Z","time spent":"1.387252698s","remote":"127.0.0.1:55282","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":"info","ts":"2026-03-30T23:48:38.103614Z","caller":"traceutil/trace.go:172","msg":"trace[1792824706] range","detail":"{range_begin:/registry/certificatesigningrequests; range_end:; response_count:0; response_revision:1171; }","duration":"837.398585ms","start":"2026-03-30T23:48:37.266180Z","end":"2026-03-30T23:48:38.103578Z","steps":["trace[1792824706] 'agreement among raft nodes before linearized reading' (duration: 834.685406ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:48:38.103704Z","caller":"traceutil/trace.go:172","msg":"trace[1378649419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1171; }","duration":"1.052846832s","start":"2026-03-30T23:48:37.050850Z","end":"2026-03-30T23:48:38.103696Z","steps":["trace[1378649419] 'agreement among raft nodes before linearized reading' (duration: 1.050080202s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:38.103920Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:37.266151Z","time spent":"837.60393ms","remote":"127.0.0.1:54916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":28,"request content":"key:\"/registry/certificatesigningrequests\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:48:38.103871Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:48:37.050836Z","time spent":"1.053005416s","remote":"127.0.0.1:32988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T23:48:38.104011Z","caller":"traceutil/trace.go:172","msg":"trace[196551023] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1171; }","duration":"1.707499555s","start":"2026-03-30T23:48:36.396504Z","end":"2026-03-30T23:48:38.104004Z","steps":["trace[196551023] 'agreement among raft nodes before linearized reading' (duration: 1.704449589s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:48:39.629168Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40042","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:39.644832Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40050","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:39.741711Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40072","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:39.765768Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40076","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:39.783154Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40112","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:39.929462Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40124","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:44.777338Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40154","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.443578Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:46928","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.520339Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:46938","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.588282Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:46964","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.643411Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:46974","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.667965Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:46980","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.683363Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47006","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.728950Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47030","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.877491Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47046","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.900669Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47048","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.913791Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47068","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.935390Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47088","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.961987Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47124","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:55.982540Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47140","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:56.028396Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47144","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:56.068646Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47160","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:56.100363Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47184","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:56.187404Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47196","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:57.241485Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47214","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:57.251757Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47220","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:48:57.543959Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47250","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T23:49:28.033395Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073707251,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T23:49:28.145087Z","caller":"traceutil/trace.go:172","msg":"trace[1192129699] transaction","detail":"{read_only:false; response_revision:1566; number_of_response:1; }","duration":"744.067445ms","start":"2026-03-30T23:49:27.400996Z","end":"2026-03-30T23:49:28.145064Z","steps":["trace[1192129699] 'process raft request' (duration: 743.930752ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:49:28.145287Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:49:27.400969Z","time spent":"744.199508ms","remote":"127.0.0.1:54926","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-03-30T23:49:28.534509Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":725815393073707251,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T23:49:28.769933Z","caller":"traceutil/trace.go:172","msg":"trace[1489762959] linearizableReadLoop","detail":"{readStateIndex:1786; appliedIndex:1788; }","duration":"1.236822904s","start":"2026-03-30T23:49:27.533084Z","end":"2026-03-30T23:49:28.769907Z","steps":["trace[1489762959] 'read index received' (duration: 1.236814364s)","trace[1489762959] 'applied index is now lower than readState.Index' (duration: 6.61µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T23:49:28.774341Z","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":725815393073707253,"received-request-id":725815393073707251} {"level":"warn","ts":"2026-03-30T23:49:28.774991Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.241642263s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:49:28.775338Z","caller":"traceutil/trace.go:172","msg":"trace[2060087289] range","detail":"{range_begin:/registry/controllerrevisions; range_end:; response_count:0; response_revision:1568; }","duration":"1.242196003s","start":"2026-03-30T23:49:27.533076Z","end":"2026-03-30T23:49:28.775272Z","steps":["trace[2060087289] 'agreement among raft nodes before linearized reading' (duration: 1.237017527s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:49:28.775529Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:49:27.533060Z","time spent":"1.242445399s","remote":"127.0.0.1:55388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":33,"response count":0,"response size":28,"request content":"key:\"/registry/controllerrevisions\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:49:28.786304Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"389.464886ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:49:28.786339Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"861.570277ms","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":"warn","ts":"2026-03-30T23:49:28.786338Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"675.799064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T23:49:28.786532Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"802.154154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:49:28.786553Z","caller":"traceutil/trace.go:172","msg":"trace[1116420369] range","detail":"{range_begin:/registry/horizontalpodautoscalers; range_end:; response_count:0; response_revision:1569; }","duration":"802.173925ms","start":"2026-03-30T23:49:27.984371Z","end":"2026-03-30T23:49:28.786545Z","steps":["trace[1116420369] 'agreement among raft nodes before linearized reading' (duration: 802.140785ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:49:28.786581Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:49:27.984343Z","time spent":"802.230526ms","remote":"127.0.0.1:54852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers\" limit:1 "} {"level":"warn","ts":"2026-03-30T23:49:28.786591Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"290.952486ms","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-03-30T23:49:28.786616Z","caller":"traceutil/trace.go:172","msg":"trace[2080968740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1569; }","duration":"290.978066ms","start":"2026-03-30T23:49:28.495631Z","end":"2026-03-30T23:49:28.786609Z","steps":["trace[2080968740] 'agreement among raft nodes before linearized reading' (duration: 290.874924ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:49:28.786773Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"329.415273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:49:28.786793Z","caller":"traceutil/trace.go:172","msg":"trace[52716563] range","detail":"{range_begin:/registry/csinodes; range_end:; response_count:0; response_revision:1569; }","duration":"329.435723ms","start":"2026-03-30T23:49:28.457351Z","end":"2026-03-30T23:49:28.786787Z","steps":["trace[52716563] 'agreement among raft nodes before linearized reading' (duration: 329.401013ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:49:28.786810Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:49:28.457321Z","time spent":"329.483276ms","remote":"127.0.0.1:55242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":22,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes\" limit:1 "} {"level":"info","ts":"2026-03-30T23:49:28.786973Z","caller":"traceutil/trace.go:172","msg":"trace[1478801942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1569; }","duration":"676.434156ms","start":"2026-03-30T23:49:28.110522Z","end":"2026-03-30T23:49:28.786956Z","steps":["trace[1478801942] 'agreement among raft nodes before linearized reading' (duration: 675.761674ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:49:28.787085Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"395.179951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T23:49:28.786392Z","caller":"traceutil/trace.go:172","msg":"trace[1543483611] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1569; }","duration":"861.627369ms","start":"2026-03-30T23:49:27.924752Z","end":"2026-03-30T23:49:28.786379Z","steps":["trace[1543483611] 'agreement among raft nodes before linearized reading' (duration: 861.273601ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:49:28.787688Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:49:27.924717Z","time spent":"862.958913ms","remote":"127.0.0.1:54926","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-03-30T23:49:28.786492Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"718.92876ms","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-03-30T23:49:28.787458Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:49:28.110504Z","time spent":"676.936905ms","remote":"127.0.0.1:32988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T23:49:28.786374Z","caller":"traceutil/trace.go:172","msg":"trace[1404877253] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1569; }","duration":"389.548326ms","start":"2026-03-30T23:49:28.396813Z","end":"2026-03-30T23:49:28.786361Z","steps":["trace[1404877253] 'agreement among raft nodes before linearized reading' (duration: 389.245992ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:49:28.787857Z","caller":"traceutil/trace.go:172","msg":"trace[439695723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1569; }","duration":"720.255324ms","start":"2026-03-30T23:49:28.067554Z","end":"2026-03-30T23:49:28.787810Z","steps":["trace[439695723] 'agreement among raft nodes before linearized reading' (duration: 718.859248ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T23:49:28.787617Z","caller":"traceutil/trace.go:172","msg":"trace[796618901] range","detail":"{range_begin:/registry/deployments; range_end:; response_count:0; response_revision:1569; }","duration":"395.679571ms","start":"2026-03-30T23:49:28.391898Z","end":"2026-03-30T23:49:28.787577Z","steps":["trace[796618901] 'agreement among raft nodes before linearized reading' (duration: 395.165961ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T23:49:28.788003Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:49:28.067524Z","time spent":"720.427377ms","remote":"127.0.0.1:54926","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-03-30T23:49:28.788028Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T23:49:28.391854Z","time spent":"396.11018ms","remote":"127.0.0.1:55318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":28,"request content":"key:\"/registry/deployments\" limit:1 "}