{"level":"warn","ts":"2026-04-22T13:11:19.725252Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-04-22T13:11:19.726135Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-04-22T13:11:19.726159Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.105:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.19.213.105:2380","--initial-cluster=controller-2=https://199.19.213.105:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.105:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.105:2380","--name=controller-2","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-04-22T13:11:19.726364Z","caller":"etcdmain/etcd.go:107","msg":"server has already been initialized","data-dir":"/var/lib/etcd","dir-type":"member"} {"level":"warn","ts":"2026-04-22T13:11:19.726405Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T13:11:19.726428Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-04-22T13:11:19.726502Z","caller":"embed/etcd.go:544","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T13:11:19.727186Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"]} {"level":"info","ts":"2026-04-22T13:11:19.727464Z","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":true,"name":"controller-2","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.105:2380"],"listen-peer-urls":["https://199.19.213.105:2380"],"advertise-client-urls":["https://199.19.213.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"","initial-cluster-state":"new","initial-cluster-token":"","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"feature-gates":"InitialCorruptCheck=true","initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","discovery-token":"","discovery-endpoints":"","discovery-dial-timeout":"2s","discovery-request-timeout":"5s","discovery-keepalive-time":"2s","discovery-keepalive-timeout":"6s","discovery-insecure-transport":true,"discovery-insecure-skip-tls-verify":false,"discovery-cert":"","discovery-key":"","discovery-cacert":"","discovery-user":"","downgrade-check-interval":"5s","max-learners":1,"v2-deprecation":"write-only"} {"level":"info","ts":"2026-04-22T13:11:19.728354Z","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: 0xc0003ba570}"} {"level":"info","ts":"2026-04-22T13:11:19.736070Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-04-22T13:11:19.736179Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.988368ms"} {"level":"info","ts":"2026-04-22T13:11:19.736256Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":5633} {"level":"info","ts":"2026-04-22T13:11:19.784206Z","caller":"etcdserver/bootstrap.go:441","msg":"No snapshot found. Recovering WAL from scratch!"} {"level":"info","ts":"2026-04-22T13:11:19.784286Z","caller":"etcdserver/bootstrap.go:232","msg":"recovered v3 backend","backend-size-bytes":23592960,"backend-size":"24 MB","backend-size-in-use-bytes":8704000,"backend-size-in-use":"8.7 MB"} {"level":"info","ts":"2026-04-22T13:11:19.784428Z","caller":"etcdserver/bootstrap.go:90","msg":"Bootstrapping WAL from snapshot"} {"level":"info","ts":"2026-04-22T13:11:19.841622Z","caller":"etcdserver/bootstrap.go:599","msg":"restarting local member","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","commit-index":5632} {"level":"info","ts":"2026-04-22T13:11:19.841716Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-04-22T13:11:19.841834Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-04-22T13:11:19.842076Z","caller":"membership/cluster.go:605","msg":"Detected member only in v3store but missing in v2store","member":"{ID:9c8ef5a437e46b40 RaftAttributes:{PeerURLs:[https://199.19.213.105:2380] IsLearner:false} Attributes:{Name:controller-2 ClientURLs:[https://199.19.213.105:2379]}}"} {"level":"info","ts":"2026-04-22T13:11:19.842104Z","caller":"membership/cluster.go:605","msg":"Detected member only in v3store but missing in v2store","member":"{ID:f69f598a0f963672 RaftAttributes:{PeerURLs:[https://199.19.213.205:2380] IsLearner:false} Attributes:{Name:controller-1 ClientURLs:[https://199.19.213.205:2379]}}"} {"level":"info","ts":"2026-04-22T13:11:19.842112Z","caller":"membership/cluster.go:605","msg":"Detected member only in v3store but missing in v2store","member":"{ID:feae28095872982a RaftAttributes:{PeerURLs:[https://199.19.213.132:2380] IsLearner:false} Attributes:{Name:controller-3 ClientURLs:[https://199.19.213.132:2379]}}"} {"level":"info","ts":"2026-04-22T13:11:19.842155Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-04-22T13:11:19.842171Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","recovered-remote-peer-id":"9c8ef5a437e46b40","recovered-remote-peer-urls":["https://199.19.213.105:2380"],"recovered-remote-peer-is-learner":false} {"level":"info","ts":"2026-04-22T13:11:19.842178Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","recovered-remote-peer-id":"f69f598a0f963672","recovered-remote-peer-urls":["https://199.19.213.205:2380"],"recovered-remote-peer-is-learner":false} {"level":"info","ts":"2026-04-22T13:11:19.842183Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","recovered-remote-peer-id":"feae28095872982a","recovered-remote-peer-urls":["https://199.19.213.132:2380"],"recovered-remote-peer-is-learner":false} {"level":"info","ts":"2026-04-22T13:11:19.842188Z","caller":"membership/cluster.go:307","msg":"set cluster version from store","cluster-version":"3.6"} {"level":"info","ts":"2026-04-22T13:11:19.842231Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-04-22T13:11:19.842304Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-04-22T13:11:19.842467Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"9c8ef5a437e46b40 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T13:11:19.842502Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"9c8ef5a437e46b40 became follower at term 5"} {"level":"info","ts":"2026-04-22T13:11:19.842510Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft 9c8ef5a437e46b40 [peers: [], term: 5, commit: 5632, applied: 0, lastindex: 5633, lastterm: 5]"} {"level":"warn","ts":"2026-04-22T13:11:19.844061Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T13:11:19.845415Z","caller":"mvcc/kvstore.go:334","msg":"restored last compact revision","meta-bucket-name-key":"finishedCompactRev","restored-compact-revision":2346} {"level":"info","ts":"2026-04-22T13:11:19.850397Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":4893} {"level":"info","ts":"2026-04-22T13:11:19.855792Z","caller":"storage/quota.go:93","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-22T13:11:19.857109Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:19.857176Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:19.857474Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:19.857608Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:19.857589Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:19.857650Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:19.857962Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"f69f598a0f963672","remote-peer-urls":["https://199.19.213.205:2380"]} {"level":"info","ts":"2026-04-22T13:11:19.857945Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:19.858039Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:19.858070Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:19.858637Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:19.858685Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:19.858684Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:19.858720Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:19.858868Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:19.859289Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"feae28095872982a","remote-peer-urls":["https://199.19.213.132:2380"]} {"level":"info","ts":"2026-04-22T13:11:19.859359Z","caller":"etcdserver/corrupt.go:91","msg":"starting initial corruption check","local-member-id":"9c8ef5a437e46b40","timeout":"7s"} {"level":"info","ts":"2026-04-22T13:11:19.876137Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:19.876224Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"f69f598a0f963672"} {"level":"warn","ts":"2026-04-22T13:11:19.876619Z","caller":"etcdserver/corrupt.go:494","msg":"failed hash kv request","local-member-id":"9c8ef5a437e46b40","requested-revision":4893,"remote-peer-endpoint":"https://199.19.213.132:2380","error":"Get \"https://199.19.213.132:2380/members/hashkv\": dial tcp 199.19.213.132:2380: connect: connection refused"} {"level":"info","ts":"2026-04-22T13:11:19.876686Z","caller":"etcdserver/corrupt.go:172","msg":"initial corruption checking passed; no corruption","local-member-id":"9c8ef5a437e46b40"} {"level":"info","ts":"2026-04-22T13:11:19.876901Z","caller":"etcdserver/server.go:589","msg":"starting etcd server","local-member-id":"9c8ef5a437e46b40","local-server-version":"3.6.4","cluster-id":"740466542a91995c","cluster-version":"3.6"} {"level":"info","ts":"2026-04-22T13:11:19.877508Z","caller":"embed/etcd.go:766","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T13:11:19.877879Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T13:11:19.877919Z","caller":"etcdserver/server.go:499","msg":"starting initial election tick advance","election-ticks":10} {"level":"info","ts":"2026-04-22T13:11:19.877946Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T13:11:19.877993Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T13:11:19.878186Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"9c8ef5a437e46b40 switched to configuration voters=(17771021104129128050)"} {"level":"info","ts":"2026-04-22T13:11:19.878308Z","caller":"membership/cluster.go:433","msg":"ignore already added member","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","added-peer-id":"f69f598a0f963672","added-peer-peer-urls":["https://199.19.213.205:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-04-22T13:11:19.878416Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.19.213.105:2380"} {"level":"info","ts":"2026-04-22T13:11:19.878498Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.19.213.105:2380"} {"level":"info","ts":"2026-04-22T13:11:19.878627Z","caller":"membership/cluster.go:674","msg":"updated cluster version","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","from":"3.6","to":"3.5"} {"level":"info","ts":"2026-04-22T13:11:19.878695Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T13:11:19.878712Z","caller":"apply/apply.go:422","msg":"Cluster version downgrade detected, forcing snapshot","prev-cluster-version":"3.6.0","new-cluster-version":"3.5.0"} {"level":"info","ts":"2026-04-22T13:11:19.878911Z","caller":"version/monitor.go:116","msg":"cluster version differs from storage version.","cluster-version":"3.5.0","storage-version":"3.6.0"} {"level":"info","ts":"2026-04-22T13:11:19.879372Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"9c8ef5a437e46b40","initial-advertise-peer-urls":["https://199.19.213.105:2380"],"listen-peer-urls":["https://199.19.213.105:2380"],"advertise-client-urls":["https://199.19.213.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T13:11:19.879440Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T13:11:19.880009Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"9c8ef5a437e46b40","to":"f69f598a0f963672","stream-type":"stream Message"} {"level":"info","ts":"2026-04-22T13:11:19.880032Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:19.880798Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"9c8ef5a437e46b40","to":"f69f598a0f963672","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-04-22T13:11:19.880827Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:19.881387Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"9c8ef5a437e46b40 switched to configuration voters=(17771021104129128050) learners=(11281224202270829376)"} {"level":"info","ts":"2026-04-22T13:11:19.881479Z","caller":"membership/cluster.go:433","msg":"ignore already added member","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","added-peer-id":"9c8ef5a437e46b40","added-peer-peer-urls":["https://199.19.213.105:2380"],"added-peer-is-learner":true} {"level":"info","ts":"2026-04-22T13:11:19.881621Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"9c8ef5a437e46b40 switched to configuration voters=(11281224202270829376 17771021104129128050)"} {"level":"info","ts":"2026-04-22T13:11:19.881695Z","caller":"membership/cluster.go:574","msg":"ignore already promoted member in v3store","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","promoted-member-id":"9c8ef5a437e46b40"} {"level":"info","ts":"2026-04-22T13:11:19.882509Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"9c8ef5a437e46b40 switched to configuration voters=(11281224202270829376 17771021104129128050) learners=(18351649552185071658)"} {"level":"info","ts":"2026-04-22T13:11:19.882557Z","caller":"membership/cluster.go:433","msg":"ignore already added member","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","added-peer-id":"feae28095872982a","added-peer-peer-urls":["https://199.19.213.132:2380"],"added-peer-is-learner":true} {"level":"info","ts":"2026-04-22T13:11:19.882684Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"9c8ef5a437e46b40 switched to configuration voters=(11281224202270829376 17771021104129128050 18351649552185071658)"} {"level":"info","ts":"2026-04-22T13:11:19.882738Z","caller":"membership/cluster.go:574","msg":"ignore already promoted member in v3store","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","promoted-member-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:19.883450Z","caller":"etcdserver/server.go:2185","msg":"triggering snapshot","local-member-id":"9c8ef5a437e46b40","local-member-applied-index":811,"local-member-snapshot-index":0,"local-member-snapshot-count":10000,"snapshot-forced":true} {"level":"info","ts":"2026-04-22T13:11:19.884615Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"f69f598a0f963672"} {"level":"info","ts":"2026-04-22T13:11:20.054271Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.5.0"} {"level":"info","ts":"2026-04-22T13:11:20.061558Z","caller":"etcdserver/server.go:2230","msg":"saved snapshot to disk","snapshot-index":811} {"level":"info","ts":"2026-04-22T13:11:20.064008Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1233","msg":"9c8ef5a437e46b40 [logterm: 5, index: 5633, vote: 9c8ef5a437e46b40] cast MsgPreVote for f69f598a0f963672 [logterm: 6, index: 5743] at term 5"} {"level":"info","ts":"2026-04-22T13:11:20.071519Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1116","msg":"9c8ef5a437e46b40 [term: 5] received a MsgVote message with higher term from f69f598a0f963672 [term: 7]"} {"level":"info","ts":"2026-04-22T13:11:20.071597Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"9c8ef5a437e46b40 became follower at term 7"} {"level":"info","ts":"2026-04-22T13:11:20.071612Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1233","msg":"9c8ef5a437e46b40 [logterm: 5, index: 5633, vote: 0] cast MsgVote for f69f598a0f963672 [logterm: 6, index: 5743] at term 7"} {"level":"info","ts":"2026-04-22T13:11:20.077791Z","caller":"membership/cluster.go:674","msg":"updated cluster version","cluster-id":"740466542a91995c","local-member-id":"9c8ef5a437e46b40","from":"3.5","to":"3.6"} {"level":"info","ts":"2026-04-22T13:11:20.078081Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-04-22T13:11:20.078283Z","caller":"version/monitor.go:116","msg":"cluster version differs from storage version.","cluster-version":"3.6.0","storage-version":"3.5.0"} {"level":"info","ts":"2026-04-22T13:11:20.078322Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-04-22T13:11:20.078337Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: 9c8ef5a437e46b40 elected leader f69f598a0f963672 at term 7"} {"level":"info","ts":"2026-04-22T13:11:20.135555Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T13:11:20.135560Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"9c8ef5a437e46b40","local-member-attributes":"{Name:controller-2 ClientURLs:[https://199.19.213.105:2379]}","cluster-id":"740466542a91995c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T13:11:20.135578Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T13:11:20.135926Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T13:11:20.135956Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T13:11:20.136567Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-04-22T13:11:20.137258Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-04-22T13:11:20.137424Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-22T13:11:20.138626Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T13:11:20.141269Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.105:2379"} {"level":"info","ts":"2026-04-22T13:11:22.334509Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"9c8ef5a437e46b40","to":"feae28095872982a","stream-type":"stream Message"} {"level":"info","ts":"2026-04-22T13:11:22.334579Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:22.334626Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:22.338760Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"9c8ef5a437e46b40","to":"feae28095872982a","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-04-22T13:11:22.338815Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:22.355088Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:22.355753Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"9c8ef5a437e46b40","remote-peer-id":"feae28095872982a"} {"level":"info","ts":"2026-04-22T13:11:22.358001Z","caller":"etcdserver/server.go:522","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"9c8ef5a437e46b40","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} {"level":"warn","ts":"2026-04-22T13:11:40.575001Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44250","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.581596Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44278","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.608523Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44294","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.623198Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44324","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.643595Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44352","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.656441Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44354","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.670479Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44376","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.683460Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44392","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.694286Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44408","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.704152Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44414","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.714184Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44436","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.742966Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44454","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.752066Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44494","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.762246Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44510","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.771895Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44538","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.781872Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44554","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.791990Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44576","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.800909Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44590","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.812822Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44594","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.820543Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44610","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.860856Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44650","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.873057Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44656","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.882059Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44678","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.894115Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44688","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.911108Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44698","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.919253Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44714","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.927193Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44732","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.938861Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44748","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.949791Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44750","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.959249Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44776","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.972743Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44798","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.987558Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44814","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:40.998472Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44832","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.007529Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44840","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.016935Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44862","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.028961Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44876","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.042219Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44898","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.055997Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44918","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.078302Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44958","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.091414Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44974","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.108739Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44998","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.122779Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45014","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.129912Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45030","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.139675Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45046","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.151975Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45068","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.162181Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45096","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.171075Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45102","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.180531Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45130","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.198364Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45144","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.208302Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45160","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.219724Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45178","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.228675Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45192","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.251621Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45228","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.258684Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45240","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.279609Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45282","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T13:11:41.335617Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45304","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-22T13:11:41.973442Z","caller":"traceutil/trace.go:172","msg":"trace[1737240530] transaction","detail":"{read_only:false; response_revision:5167; number_of_response:1; }","duration":"163.280931ms","start":"2026-04-22T13:11:41.810141Z","end":"2026-04-22T13:11:41.973422Z","steps":["trace[1737240530] 'process raft request' (duration: 132.821276ms)","trace[1737240530] 'compare' (duration: 30.358132ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:11:42.140584Z","caller":"traceutil/trace.go:172","msg":"trace[1007232823] linearizableReadLoop","detail":"{readStateIndex:5942; appliedIndex:5942; }","duration":"316.600949ms","start":"2026-04-22T13:11:41.823945Z","end":"2026-04-22T13:11:42.140546Z","steps":["trace[1007232823] 'read index received' (duration: 316.542617ms)","trace[1007232823] 'applied index is now lower than readState.Index' (duration: 9.521µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:11:42.197612Z","caller":"traceutil/trace.go:172","msg":"trace[1585007409] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5168; }","duration":"222.655931ms","start":"2026-04-22T13:11:41.974931Z","end":"2026-04-22T13:11:42.197587Z","steps":["trace[1585007409] 'process raft request' (duration: 222.487717ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:11:42.197645Z","caller":"traceutil/trace.go:172","msg":"trace[1378808704] transaction","detail":"{read_only:false; response_revision:5168; number_of_response:1; }","duration":"318.061801ms","start":"2026-04-22T13:11:41.879560Z","end":"2026-04-22T13:11:42.197622Z","steps":["trace[1378808704] 'process raft request' (duration: 261.049838ms)","trace[1378808704] 'compare' (duration: 56.662414ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:11:42.198129Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:11:41.879535Z","time spent":"318.165493ms","remote":"127.0.0.1:44694","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-04-22T13:11:42.198335Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"374.338428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.105\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:11:42.198402Z","caller":"traceutil/trace.go:172","msg":"trace[76755310] range","detail":"{range_begin:/registry/masterleases/199.19.213.105; range_end:; response_count:0; response_revision:5167; }","duration":"374.44077ms","start":"2026-04-22T13:11:41.823940Z","end":"2026-04-22T13:11:42.198381Z","steps":["trace[76755310] 'agreement among raft nodes before linearized reading' (duration: 316.738172ms)","trace[76755310] 'range keys from in-memory index tree' (duration: 56.4924ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:11:42.198440Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:11:41.823928Z","time spent":"374.501131ms","remote":"127.0.0.1:44306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.19.213.105\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:11:42.481369Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"175.614956ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:11:42.481467Z","caller":"traceutil/trace.go:172","msg":"trace[533678992] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5169; }","duration":"175.729139ms","start":"2026-04-22T13:11:42.305716Z","end":"2026-04-22T13:11:42.481445Z","steps":["trace[533678992] 'range keys from in-memory index tree' (duration: 175.565895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:11:42.481563Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"171.020715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:11:42.481957Z","caller":"traceutil/trace.go:172","msg":"trace[916616407] transaction","detail":"{read_only:false; response_revision:5170; number_of_response:1; }","duration":"277.956375ms","start":"2026-04-22T13:11:42.203977Z","end":"2026-04-22T13:11:42.481933Z","steps":["trace[916616407] 'process raft request' (duration: 106.437359ms)","trace[916616407] 'compare' (duration: 170.876922ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:11:42.482042Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"229.768735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:11:42.482083Z","caller":"traceutil/trace.go:172","msg":"trace[1374284600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5174; }","duration":"229.810036ms","start":"2026-04-22T13:11:42.252261Z","end":"2026-04-22T13:11:42.482071Z","steps":["trace[1374284600] 'agreement among raft nodes before linearized reading' (duration: 229.741415ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:11:42.481972Z","caller":"traceutil/trace.go:172","msg":"trace[100445730] linearizableReadLoop","detail":"{readStateIndex:5947; appliedIndex:5945; }","duration":"229.690034ms","start":"2026-04-22T13:11:42.252266Z","end":"2026-04-22T13:11:42.481956Z","steps":["trace[100445730] 'read index received' (duration: 121.400524ms)","trace[100445730] 'applied index is now lower than readState.Index' (duration: 108.2884ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:11:42.578793Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"321.478772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:11:42.578863Z","caller":"traceutil/trace.go:172","msg":"trace[1093209268] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:5174; }","duration":"321.948372ms","start":"2026-04-22T13:11:42.256901Z","end":"2026-04-22T13:11:42.578850Z","steps":["trace[1093209268] 'agreement among raft nodes before linearized reading' (duration: 321.441191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:11:42.578898Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:11:42.256878Z","time spent":"322.012614ms","remote":"127.0.0.1:44466","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":"info","ts":"2026-04-22T13:11:42.718170Z","caller":"traceutil/trace.go:172","msg":"trace[1502526235] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"134.830667ms","start":"2026-04-22T13:11:42.583313Z","end":"2026-04-22T13:11:42.718144Z","steps":["trace[1502526235] 'process raft request' (duration: 134.652083ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:11:43.560552Z","caller":"traceutil/trace.go:172","msg":"trace[1810847398] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"225.484137ms","start":"2026-04-22T13:11:43.335033Z","end":"2026-04-22T13:11:43.560517Z","steps":["trace[1810847398] 'process raft request' (duration: 150.982356ms)","trace[1810847398] 'compare' (duration: 74.192964ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:11:44.729529Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"145.185827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T13:11:44.729634Z","caller":"traceutil/trace.go:172","msg":"trace[1435438403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5185; }","duration":"145.2997ms","start":"2026-04-22T13:11:44.584306Z","end":"2026-04-22T13:11:44.729606Z","steps":["trace[1435438403] 'agreement among raft nodes before linearized reading' (duration: 60.068736ms)","trace[1435438403] 'range keys from in-memory index tree' (duration: 85.07408ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:11:47.701648Z","caller":"traceutil/trace.go:172","msg":"trace[1846166680] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"155.639128ms","start":"2026-04-22T13:11:47.545965Z","end":"2026-04-22T13:11:47.701604Z","steps":["trace[1846166680] 'process raft request' (duration: 154.372491ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:11:47.702465Z","caller":"traceutil/trace.go:172","msg":"trace[1977765474] linearizableReadLoop","detail":"{readStateIndex:5980; appliedIndex:5980; }","duration":"122.53169ms","start":"2026-04-22T13:11:47.579914Z","end":"2026-04-22T13:11:47.702445Z","steps":["trace[1977765474] 'read index received' (duration: 122.52747ms)","trace[1977765474] 'applied index is now lower than readState.Index' (duration: 3.33µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:11:47.702643Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"122.707763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-vip-controller-2.18a8afe6aa3cb057\" limit:1 ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-04-22T13:11:47.702682Z","caller":"traceutil/trace.go:172","msg":"trace[1144974317] range","detail":"{range_begin:/registry/events/kube-system/kube-vip-controller-2.18a8afe6aa3cb057; range_end:; response_count:1; response_revision:5200; }","duration":"122.761154ms","start":"2026-04-22T13:11:47.579910Z","end":"2026-04-22T13:11:47.702671Z","steps":["trace[1144974317] 'agreement among raft nodes before linearized reading' (duration: 122.596531ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:11:48.478836Z","caller":"traceutil/trace.go:172","msg":"trace[604150454] transaction","detail":"{read_only:false; response_revision:5228; number_of_response:1; }","duration":"110.16288ms","start":"2026-04-22T13:11:48.368636Z","end":"2026-04-22T13:11:48.478799Z","steps":["trace[604150454] 'process raft request' (duration: 67.895583ms)","trace[604150454] 'compare' (duration: 42.072233ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:11:49.021584Z","caller":"traceutil/trace.go:172","msg":"trace[373059183] transaction","detail":"{read_only:false; response_revision:5242; number_of_response:1; }","duration":"159.352986ms","start":"2026-04-22T13:11:48.862155Z","end":"2026-04-22T13:11:49.021508Z","steps":["trace[373059183] 'process raft request' (duration: 140.64808ms)","trace[373059183] 'compare' (duration: 18.549681ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:11:57.021763Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"339.350288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:11:57.027322Z","caller":"traceutil/trace.go:172","msg":"trace[1933178293] linearizableReadLoop","detail":"{readStateIndex:6080; appliedIndex:6080; }","duration":"324.952399ms","start":"2026-04-22T13:11:56.702353Z","end":"2026-04-22T13:11:57.027305Z","steps":["trace[1933178293] 'read index received' (duration: 324.947099ms)","trace[1933178293] 'applied index is now lower than readState.Index' (duration: 4.43µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:11:57.027522Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"325.156323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:511"} {"level":"info","ts":"2026-04-22T13:11:57.027550Z","caller":"traceutil/trace.go:172","msg":"trace[2061531611] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5295; }","duration":"325.202514ms","start":"2026-04-22T13:11:56.702339Z","end":"2026-04-22T13:11:57.027542Z","steps":["trace[2061531611] 'agreement among raft nodes before linearized reading' (duration: 325.064541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:11:57.027591Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:11:56.702316Z","time spent":"325.266645ms","remote":"127.0.0.1:44694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":534,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:11:59.033952Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"336.100049ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-04-22T13:12:03.476186Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"166.83646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.105\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-22T13:12:03.476215Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"170.962739ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:12:03.476285Z","caller":"traceutil/trace.go:172","msg":"trace[1886737596] range","detail":"{range_begin:/registry/masterleases/199.19.213.105; range_end:; response_count:1; response_revision:5317; }","duration":"166.962773ms","start":"2026-04-22T13:12:03.309304Z","end":"2026-04-22T13:12:03.476266Z","steps":["trace[1886737596] 'range keys from in-memory index tree' (duration: 164.855188ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:12:03.476328Z","caller":"traceutil/trace.go:172","msg":"trace[547232657] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5317; }","duration":"171.108372ms","start":"2026-04-22T13:12:03.305197Z","end":"2026-04-22T13:12:03.476305Z","steps":["trace[547232657] 'range keys from in-memory index tree' (duration: 170.894369ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:12:03.630668Z","caller":"traceutil/trace.go:172","msg":"trace[1041545768] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"109.878199ms","start":"2026-04-22T13:12:03.520753Z","end":"2026-04-22T13:12:03.630631Z","steps":["trace[1041545768] 'process raft request' (duration: 69.760897ms)","trace[1041545768] 'compare' (duration: 39.807835ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:12:07.850608Z","caller":"traceutil/trace.go:172","msg":"trace[1014426934] transaction","detail":"{read_only:false; response_revision:5336; number_of_response:1; }","duration":"150.182496ms","start":"2026-04-22T13:12:07.700411Z","end":"2026-04-22T13:12:07.850593Z","steps":["trace[1014426934] 'process raft request' (duration: 144.365711ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:12:08.141484Z","caller":"traceutil/trace.go:172","msg":"trace[1845664901] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"247.037307ms","start":"2026-04-22T13:12:07.894421Z","end":"2026-04-22T13:12:08.141458Z","steps":["trace[1845664901] 'process raft request' (duration: 217.593247ms)","trace[1845664901] 'compare' (duration: 28.862248ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:12:08.449176Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"143.922839ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:12:08.449252Z","caller":"traceutil/trace.go:172","msg":"trace[2076973755] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5339; }","duration":"144.013141ms","start":"2026-04-22T13:12:08.305223Z","end":"2026-04-22T13:12:08.449236Z","steps":["trace[2076973755] 'range keys from in-memory index tree' (duration: 142.138501ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:12:09.844330Z","caller":"traceutil/trace.go:172","msg":"trace[1217608258] linearizableReadLoop","detail":"{readStateIndex:6137; appliedIndex:6137; }","duration":"156.784442ms","start":"2026-04-22T13:12:09.687527Z","end":"2026-04-22T13:12:09.844311Z","steps":["trace[1217608258] 'read index received' (duration: 156.770582ms)","trace[1217608258] 'applied index is now lower than readState.Index' (duration: 12.61µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:12:09.844595Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"157.025957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-04-22T13:12:09.844676Z","caller":"traceutil/trace.go:172","msg":"trace[28276142] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5345; }","duration":"157.140759ms","start":"2026-04-22T13:12:09.687520Z","end":"2026-04-22T13:12:09.844660Z","steps":["trace[28276142] 'agreement among raft nodes before linearized reading' (duration: 156.881304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:12:09.846173Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"145.078872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T13:12:09.846215Z","caller":"traceutil/trace.go:172","msg":"trace[780270415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5345; }","duration":"145.150754ms","start":"2026-04-22T13:12:09.701053Z","end":"2026-04-22T13:12:09.846203Z","steps":["trace[780270415] 'agreement among raft nodes before linearized reading' (duration: 144.945279ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:12:15.503374Z","caller":"traceutil/trace.go:172","msg":"trace[1004807582] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"185.345247ms","start":"2026-04-22T13:12:15.318001Z","end":"2026-04-22T13:12:15.503347Z","steps":["trace[1004807582] 'process raft request' (duration: 185.120162ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:12:37.639529Z","caller":"traceutil/trace.go:172","msg":"trace[1438577001] transaction","detail":"{read_only:false; response_revision:5465; number_of_response:1; }","duration":"126.221382ms","start":"2026-04-22T13:12:37.513269Z","end":"2026-04-22T13:12:37.639491Z","steps":["trace[1438577001] 'process raft request' (duration: 125.941836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:12:50.769287Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7728350362641900733,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T13:12:51.122275Z","caller":"traceutil/trace.go:172","msg":"trace[365020715] linearizableReadLoop","detail":"{readStateIndex:6330; appliedIndex:6330; }","duration":"853.61471ms","start":"2026-04-22T13:12:50.268635Z","end":"2026-04-22T13:12:51.122249Z","steps":["trace[365020715] 'read index received' (duration: 853.60656ms)","trace[365020715] 'applied index is now lower than readState.Index' (duration: 6.61µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:12:51.122558Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"853.916086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:12:51.122594Z","caller":"traceutil/trace.go:172","msg":"trace[1141645870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5512; }","duration":"853.963617ms","start":"2026-04-22T13:12:50.268620Z","end":"2026-04-22T13:12:51.122584Z","steps":["trace[1141645870] 'agreement among raft nodes before linearized reading' (duration: 853.873035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:12:51.122628Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:12:50.268589Z","time spent":"854.029649ms","remote":"127.0.0.1:44266","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-04-22T13:12:51.128445Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"821.893138ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:12:51.128520Z","caller":"traceutil/trace.go:172","msg":"trace[135850552] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5514; }","duration":"821.97703ms","start":"2026-04-22T13:12:50.306527Z","end":"2026-04-22T13:12:51.128504Z","steps":["trace[135850552] 'agreement among raft nodes before linearized reading' (duration: 821.873978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:12:51.128521Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"277.195927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:12:51.128443Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"315.027825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:12:51.128608Z","caller":"traceutil/trace.go:172","msg":"trace[2093599892] range","detail":"{range_begin:/registry/clusterroles; range_end:; response_count:0; response_revision:5514; }","duration":"277.293159ms","start":"2026-04-22T13:12:50.851297Z","end":"2026-04-22T13:12:51.128591Z","steps":["trace[2093599892] 'agreement among raft nodes before linearized reading' (duration: 277.156836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:12:51.128589Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"517.716139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-04-22T13:12:51.128732Z","caller":"traceutil/trace.go:172","msg":"trace[4673370] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:5514; }","duration":"315.27112ms","start":"2026-04-22T13:12:50.813394Z","end":"2026-04-22T13:12:51.128666Z","steps":["trace[4673370] 'agreement among raft nodes before linearized reading' (duration: 314.997985ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:12:51.128913Z","caller":"traceutil/trace.go:172","msg":"trace[1908086757] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5514; }","duration":"518.051696ms","start":"2026-04-22T13:12:50.610845Z","end":"2026-04-22T13:12:51.128897Z","steps":["trace[1908086757] 'agreement among raft nodes before linearized reading' (duration: 517.563626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:12:51.129644Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:12:50.610819Z","time spent":"518.805632ms","remote":"127.0.0.1:44694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:12:51.129712Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:12:50.813373Z","time spent":"316.080507ms","remote":"127.0.0.1:44890","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-04-22T13:12:52.238980Z","caller":"traceutil/trace.go:172","msg":"trace[1579659731] linearizableReadLoop","detail":"{readStateIndex:6338; appliedIndex:6338; }","duration":"347.910534ms","start":"2026-04-22T13:12:51.891045Z","end":"2026-04-22T13:12:52.238956Z","steps":["trace[1579659731] 'read index received' (duration: 347.903144ms)","trace[1579659731] 'applied index is now lower than readState.Index' (duration: 5.71µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:12:52.239146Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"348.087058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:12:52.239177Z","caller":"traceutil/trace.go:172","msg":"trace[1413080164] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices; range_end:; response_count:0; response_revision:5518; }","duration":"348.138759ms","start":"2026-04-22T13:12:51.891029Z","end":"2026-04-22T13:12:52.239168Z","steps":["trace[1413080164] 'agreement among raft nodes before linearized reading' (duration: 348.048027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:12:52.239216Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:12:51.891000Z","time spent":"348.20349ms","remote":"127.0.0.1:45290","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-04-22T13:12:52.240483Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"175.897742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:12:52.240548Z","caller":"traceutil/trace.go:172","msg":"trace[1782450162] range","detail":"{range_begin:/registry/persistentvolumeclaims; range_end:; response_count:0; response_revision:5518; }","duration":"175.962284ms","start":"2026-04-22T13:12:52.064569Z","end":"2026-04-22T13:12:52.240532Z","steps":["trace[1782450162] 'agreement among raft nodes before linearized reading' (duration: 175.867462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:31.320882Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7728350362641900973,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T13:13:31.821561Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7728350362641900973,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T13:13:31.909178Z","caller":"traceutil/trace.go:172","msg":"trace[677899526] linearizableReadLoop","detail":"{readStateIndex:6509; appliedIndex:6509; }","duration":"1.089209367s","start":"2026-04-22T13:13:30.819944Z","end":"2026-04-22T13:13:31.909153Z","steps":["trace[677899526] 'read index received' (duration: 1.089201096s)","trace[677899526] 'applied index is now lower than readState.Index' (duration: 6.031µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:13:31.913154Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.093194518s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T13:13:31.913204Z","caller":"traceutil/trace.go:172","msg":"trace[1356198107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5667; }","duration":"1.093260709s","start":"2026-04-22T13:13:30.819931Z","end":"2026-04-22T13:13:31.913192Z","steps":["trace[1356198107] 'agreement among raft nodes before linearized reading' (duration: 1.089330279s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:31.913264Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:30.819911Z","time spent":"1.09332065s","remote":"127.0.0.1:44694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:13:31.923039Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.008184563s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:511"} {"level":"info","ts":"2026-04-22T13:13:31.923090Z","caller":"traceutil/trace.go:172","msg":"trace[1928134896] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5670; }","duration":"1.008247214s","start":"2026-04-22T13:13:30.914833Z","end":"2026-04-22T13:13:31.923080Z","steps":["trace[1928134896] 'agreement among raft nodes before linearized reading' (duration: 1.008110842s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:31.923117Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:30.914808Z","time spent":"1.008303696s","remote":"127.0.0.1:44694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":534,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:13:31.923355Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"654.873731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:31.923420Z","caller":"traceutil/trace.go:172","msg":"trace[223079348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5670; }","duration":"654.937552ms","start":"2026-04-22T13:13:31.268474Z","end":"2026-04-22T13:13:31.923411Z","steps":["trace[223079348] 'agreement among raft nodes before linearized reading' (duration: 654.85264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:31.923441Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:31.268454Z","time spent":"654.982463ms","remote":"127.0.0.1:44266","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-04-22T13:13:31.923479Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"753.193975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceclaims\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:31.923591Z","caller":"traceutil/trace.go:172","msg":"trace[1100809070] range","detail":"{range_begin:/registry/resourceclaims; range_end:; response_count:0; response_revision:5670; }","duration":"753.329987ms","start":"2026-04-22T13:13:31.170239Z","end":"2026-04-22T13:13:31.923569Z","steps":["trace[1100809070] 'agreement among raft nodes before linearized reading' (duration: 753.118133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:31.923609Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"618.481568ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:13:31.923637Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:31.170215Z","time spent":"753.412999ms","remote":"127.0.0.1:45256","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":"info","ts":"2026-04-22T13:13:31.923639Z","caller":"traceutil/trace.go:172","msg":"trace[1461533476] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5670; }","duration":"618.509368ms","start":"2026-04-22T13:13:31.305120Z","end":"2026-04-22T13:13:31.923629Z","steps":["trace[1461533476] 'agreement among raft nodes before linearized reading' (duration: 618.468798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:31.923955Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"341.557282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:31.924241Z","caller":"traceutil/trace.go:172","msg":"trace[2028166783] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations; range_end:; response_count:0; response_revision:5670; }","duration":"341.845869ms","start":"2026-04-22T13:13:31.582388Z","end":"2026-04-22T13:13:31.924234Z","steps":["trace[2028166783] 'agreement among raft nodes before linearized reading' (duration: 340.890438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:31.924276Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:31.582365Z","time spent":"341.90053ms","remote":"127.0.0.1:45150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 "} {"level":"info","ts":"2026-04-22T13:13:32.559114Z","caller":"traceutil/trace.go:172","msg":"trace[1105178253] linearizableReadLoop","detail":"{readStateIndex:6516; appliedIndex:6516; }","duration":"286.915416ms","start":"2026-04-22T13:13:32.272176Z","end":"2026-04-22T13:13:32.559092Z","steps":["trace[1105178253] 'read index received' (duration: 286.904086ms)","trace[1105178253] 'applied index is now lower than readState.Index' (duration: 10.15µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:13:32.559884Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"287.660021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-04-22T13:13:32.559989Z","caller":"traceutil/trace.go:172","msg":"trace[641478902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5673; }","duration":"287.814874ms","start":"2026-04-22T13:13:32.272157Z","end":"2026-04-22T13:13:32.559972Z","steps":["trace[641478902] 'agreement among raft nodes before linearized reading' (duration: 287.441966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:32.561538Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"255.848843ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:32.561571Z","caller":"traceutil/trace.go:172","msg":"trace[1954340942] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5673; }","duration":"255.883664ms","start":"2026-04-22T13:13:32.305680Z","end":"2026-04-22T13:13:32.561564Z","steps":["trace[1954340942] 'agreement among raft nodes before linearized reading' (duration: 255.832383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:34.805524Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7728350362641900991,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T13:13:35.306788Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7728350362641900991,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T13:13:35.525453Z","caller":"traceutil/trace.go:172","msg":"trace[768293079] transaction","detail":"{read_only:false; response_revision:5681; number_of_response:1; }","duration":"998.361868ms","start":"2026-04-22T13:13:34.527066Z","end":"2026-04-22T13:13:35.525427Z","steps":["trace[768293079] 'process raft request' (duration: 998.220505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:35.525637Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:34.527033Z","time spent":"998.514291ms","remote":"127.0.0.1:44694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:13:35.526096Z","caller":"traceutil/trace.go:172","msg":"trace[299036483] linearizableReadLoop","detail":"{readStateIndex:6524; appliedIndex:6526; }","duration":"1.221028281s","start":"2026-04-22T13:13:34.305034Z","end":"2026-04-22T13:13:35.526062Z","steps":["trace[299036483] 'read index received' (duration: 1.221018901s)","trace[299036483] 'applied index is now lower than readState.Index' (duration: 7.83µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:13:35.526286Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.221219355s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:35.526381Z","caller":"traceutil/trace.go:172","msg":"trace[1458735758] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5681; }","duration":"1.221332067s","start":"2026-04-22T13:13:34.305027Z","end":"2026-04-22T13:13:35.526359Z","steps":["trace[1458735758] 'agreement among raft nodes before linearized reading' (duration: 1.221175884s)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:13:35.526396Z","caller":"traceutil/trace.go:172","msg":"trace[1899906675] transaction","detail":"{read_only:false; response_revision:5682; number_of_response:1; }","duration":"343.801024ms","start":"2026-04-22T13:13:35.182582Z","end":"2026-04-22T13:13:35.526383Z","steps":["trace[1899906675] 'process raft request' (duration: 343.668912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:35.526510Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:35.182555Z","time spent":"343.881666ms","remote":"127.0.0.1:44694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":536,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:13:35.529319Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"285.943789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:35.529385Z","caller":"traceutil/trace.go:172","msg":"trace[1082423687] range","detail":"{range_begin:/registry/statefulsets; range_end:; response_count:0; response_revision:5682; }","duration":"286.0117ms","start":"2026-04-22T13:13:35.243357Z","end":"2026-04-22T13:13:35.529369Z","steps":["trace[1082423687] 'agreement among raft nodes before linearized reading' (duration: 285.843407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:35.529641Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"260.768507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:35.529690Z","caller":"traceutil/trace.go:172","msg":"trace[2052708987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5682; }","duration":"260.817238ms","start":"2026-04-22T13:13:35.268859Z","end":"2026-04-22T13:13:35.529676Z","steps":["trace[2052708987] 'agreement among raft nodes before linearized reading' (duration: 260.730877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:35.529780Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"918.142855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:511"} {"level":"info","ts":"2026-04-22T13:13:35.529833Z","caller":"traceutil/trace.go:172","msg":"trace[822204224] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5682; }","duration":"918.975912ms","start":"2026-04-22T13:13:34.610841Z","end":"2026-04-22T13:13:35.529817Z","steps":["trace[822204224] 'agreement among raft nodes before linearized reading' (duration: 917.997642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:35.529965Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"527.3098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-04-22T13:13:35.530010Z","caller":"traceutil/trace.go:172","msg":"trace[704313944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5682; }","duration":"527.371631ms","start":"2026-04-22T13:13:35.002627Z","end":"2026-04-22T13:13:35.529998Z","steps":["trace[704313944] 'agreement among raft nodes before linearized reading' (duration: 527.193577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:35.530036Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:35.002594Z","time spent":"527.435052ms","remote":"127.0.0.1:44694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-04-22T13:13:35.530120Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"864.907952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-22T13:13:35.530165Z","caller":"traceutil/trace.go:172","msg":"trace[1490007557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5682; }","duration":"864.953823ms","start":"2026-04-22T13:13:34.665201Z","end":"2026-04-22T13:13:35.530155Z","steps":["trace[1490007557] 'agreement among raft nodes before linearized reading' (duration: 864.873291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:35.530195Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:34.665176Z","time spent":"865.011695ms","remote":"127.0.0.1:44694","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-04-22T13:13:35.530247Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"513.001978ms","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":"warn","ts":"2026-04-22T13:13:35.530103Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:34.610814Z","time spent":"919.041774ms","remote":"127.0.0.1:44694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":534,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"info","ts":"2026-04-22T13:13:35.530313Z","caller":"traceutil/trace.go:172","msg":"trace[413631229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5682; }","duration":"513.071119ms","start":"2026-04-22T13:13:35.017233Z","end":"2026-04-22T13:13:35.530304Z","steps":["trace[413631229] 'agreement among raft nodes before linearized reading' (duration: 512.821424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:35.530343Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:35.017193Z","time spent":"513.140651ms","remote":"127.0.0.1:44694","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":"info","ts":"2026-04-22T13:13:40.280165Z","caller":"traceutil/trace.go:172","msg":"trace[1647955484] linearizableReadLoop","detail":"{readStateIndex:6548; appliedIndex:6548; }","duration":"378.066334ms","start":"2026-04-22T13:13:39.902072Z","end":"2026-04-22T13:13:40.280138Z","steps":["trace[1647955484] 'read index received' (duration: 378.060834ms)","trace[1647955484] 'applied index is now lower than readState.Index' (duration: 3.91µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:13:40.280640Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"378.509943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-04-22T13:13:40.280856Z","caller":"traceutil/trace.go:172","msg":"trace[1443319513] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5700; }","duration":"378.81168ms","start":"2026-04-22T13:13:39.902028Z","end":"2026-04-22T13:13:40.280840Z","steps":["trace[1443319513] 'agreement among raft nodes before linearized reading' (duration: 378.35679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:40.280970Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:39.902000Z","time spent":"378.953723ms","remote":"127.0.0.1:44694","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":"info","ts":"2026-04-22T13:13:41.629342Z","caller":"traceutil/trace.go:172","msg":"trace[335891626] linearizableReadLoop","detail":"{readStateIndex:6552; appliedIndex:6552; }","duration":"323.253396ms","start":"2026-04-22T13:13:41.306067Z","end":"2026-04-22T13:13:41.629321Z","steps":["trace[335891626] 'read index received' (duration: 323.247766ms)","trace[335891626] 'applied index is now lower than readState.Index' (duration: 4.58µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:13:41.633432Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"327.290368ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:41.633578Z","caller":"traceutil/trace.go:172","msg":"trace[1142412318] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5703; }","duration":"327.492572ms","start":"2026-04-22T13:13:41.306054Z","end":"2026-04-22T13:13:41.633546Z","steps":["trace[1142412318] 'agreement among raft nodes before linearized reading' (duration: 323.3857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:41.633794Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"129.308944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-22T13:13:41.633929Z","caller":"traceutil/trace.go:172","msg":"trace[395207679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5703; }","duration":"129.469177ms","start":"2026-04-22T13:13:41.504431Z","end":"2026-04-22T13:13:41.633900Z","steps":["trace[395207679] 'agreement among raft nodes before linearized reading' (duration: 129.021818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:42.768991Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7728350362641901021,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T13:13:43.031433Z","caller":"traceutil/trace.go:172","msg":"trace[346063463] linearizableReadLoop","detail":"{readStateIndex:6555; appliedIndex:6560; }","duration":"762.802276ms","start":"2026-04-22T13:13:42.268604Z","end":"2026-04-22T13:13:43.031406Z","steps":["trace[346063463] 'read index received' (duration: 762.794676ms)","trace[346063463] 'applied index is now lower than readState.Index' (duration: 6.01µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:13:43.031548Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"762.94072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:43.031639Z","caller":"traceutil/trace.go:172","msg":"trace[1026761216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5710; }","duration":"763.037532ms","start":"2026-04-22T13:13:42.268583Z","end":"2026-04-22T13:13:43.031620Z","steps":["trace[1026761216] 'agreement among raft nodes before linearized reading' (duration: 762.909308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:43.031677Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T13:13:42.268549Z","time spent":"763.120503ms","remote":"127.0.0.1:44266","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-04-22T13:13:43.032878Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"726.972431ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:43.032985Z","caller":"traceutil/trace.go:172","msg":"trace[1494692180] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5710; }","duration":"727.108643ms","start":"2026-04-22T13:13:42.305855Z","end":"2026-04-22T13:13:43.032964Z","steps":["trace[1494692180] 'agreement among raft nodes before linearized reading' (duration: 726.92732ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:13:43.722400Z","caller":"traceutil/trace.go:172","msg":"trace[1763639868] transaction","detail":"{read_only:false; response_revision:5711; number_of_response:1; }","duration":"223.892407ms","start":"2026-04-22T13:13:43.498483Z","end":"2026-04-22T13:13:43.722376Z","steps":["trace[1763639868] 'process raft request' (duration: 223.52164ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:13:43.723067Z","caller":"traceutil/trace.go:172","msg":"trace[1809156921] linearizableReadLoop","detail":"{readStateIndex:6562; appliedIndex:6562; }","duration":"147.424537ms","start":"2026-04-22T13:13:43.575581Z","end":"2026-04-22T13:13:43.723006Z","steps":["trace[1809156921] 'read index received' (duration: 147.414147ms)","trace[1809156921] 'applied index is now lower than readState.Index' (duration: 8.31µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:13:43.723382Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"147.777104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:43.723438Z","caller":"traceutil/trace.go:172","msg":"trace[993560463] range","detail":"{range_begin:/registry/csistoragecapacities; range_end:; response_count:0; response_revision:5711; }","duration":"147.863306ms","start":"2026-04-22T13:13:43.575559Z","end":"2026-04-22T13:13:43.723423Z","steps":["trace[993560463] 'agreement among raft nodes before linearized reading' (duration: 147.706223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:51.527192Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"283.764109ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-22T13:13:51.548952Z","caller":"traceutil/trace.go:172","msg":"trace[758995575] linearizableReadLoop","detail":"{readStateIndex:6595; appliedIndex:6593; }","duration":"280.372761ms","start":"2026-04-22T13:13:51.268465Z","end":"2026-04-22T13:13:51.548837Z","steps":["trace[758995575] 'read index received' (duration: 1.521101ms)","trace[758995575] 'applied index is now lower than readState.Index' (duration: 278.838689ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:13:51.549116Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"280.640546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:51.549322Z","caller":"traceutil/trace.go:172","msg":"trace[65429700] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5742; }","duration":"280.86119ms","start":"2026-04-22T13:13:51.268446Z","end":"2026-04-22T13:13:51.549308Z","steps":["trace[65429700] 'agreement among raft nodes before linearized reading' (duration: 280.570424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:51.550718Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.281105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-22T13:13:51.550791Z","caller":"traceutil/trace.go:172","msg":"trace[2139142300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5742; }","duration":"101.367397ms","start":"2026-04-22T13:13:51.449413Z","end":"2026-04-22T13:13:51.550780Z","steps":["trace[2139142300] 'agreement among raft nodes before linearized reading' (duration: 101.187964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:13:51.550810Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"173.280889ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:13:51.550884Z","caller":"traceutil/trace.go:172","msg":"trace[1051322421] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5742; }","duration":"173.35536ms","start":"2026-04-22T13:13:51.377517Z","end":"2026-04-22T13:13:51.550872Z","steps":["trace[1051322421] 'agreement among raft nodes before linearized reading' (duration: 173.094505ms)"],"step_count":1}