{"level":"warn","ts":"2026-05-20T20:55:57.044517Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-05-20T20:55:57.044649Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-05-20T20:55:57.044675Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.204.45.38:2380","--initial-cluster=controller=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38:2380","--name=controller","--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-05-20T20:55:57.044784Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-05-20T20:55:57.044819Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T20:55:57.044843Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-05-20T20:55:57.044866Z","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-05-20T20:55:57.046041Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-05-20T20:55:57.046917Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.204.45.38:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"feature-gates":"InitialCorruptCheck=true","initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","discovery-token":"","discovery-endpoints":"","discovery-dial-timeout":"2s","discovery-request-timeout":"5s","discovery-keepalive-time":"2s","discovery-keepalive-timeout":"6s","discovery-insecure-transport":true,"discovery-insecure-skip-tls-verify":false,"discovery-cert":"","discovery-key":"","discovery-cacert":"","discovery-user":"","downgrade-check-interval":"5s","max-learners":1,"v2-deprecation":"write-only"} {"level":"info","ts":"2026-05-20T20:55:57.047749Z","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: 0xc0005840f8}"} {"level":"info","ts":"2026-05-20T20:55:57.058108Z","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-05-20T20:55:57.058432Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.789457ms"} {"level":"info","ts":"2026-05-20T20:55:57.058512Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-05-20T20:55:57.058550Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-05-20T20:55:57.058609Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-05-20T20:55:57.081981Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-05-20T20:55:57.082175Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-05-20T20:55:57.082231Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-05-20T20:55:57.082354Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T20:55:57.082427Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-05-20T20:55:57.082458Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T20:55:57.082488Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-05-20T20:55:57.082553Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-05-20T20:55:57.094893Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T20:55:57.099936Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T20:55:57.108133Z","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-05-20T20:55:57.108921Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T20:55:57.109118Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T20:55:57.109279Z","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-05-20T20:55:57.109947Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T20:55:57.110002Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T20:55:57.109122Z","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-05-20T20:55:57.110349Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-20T20:55:57.110380Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-20T20:55:57.110376Z","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-05-20T20:55:57.110473Z","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-05-20T20:55:57.111051Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-05-20T20:55:57.111213Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-05-20T20:55:57.583120Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T20:55:57.583202Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T20:55:57.583405Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-05-20T20:55:57.583431Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"331455d6226d3423 has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-20T20:55:57.583450Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-05-20T20:55:57.586204Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-20T20:55:57.586228Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"331455d6226d3423 has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-20T20:55:57.586245Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-05-20T20:55:57.586254Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-20T20:55:57.588746Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:controller ClientURLs:[https://199.204.45.38:2379]}","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T20:55:57.588820Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T20:55:57.589012Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T20:55:57.589204Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T20:55:57.589393Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T20:55:57.589440Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T20:55:57.590499Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-05-20T20:55:57.591144Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-05-20T20:55:57.591337Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-05-20T20:55:57.595397Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T20:55:57.595570Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T20:55:57.595638Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T20:55:57.596287Z","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-05-20T20:55:57.596990Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-05-20T20:55:57.597973Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-05-20T20:55:57.598269Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-20T20:55:57.598586Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33950","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.598779Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33978","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.609287Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33994","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.628837Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34028","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.643705Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34056","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.654606Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34058","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.666814Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34070","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.677097Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34114","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.685442Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34128","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.693848Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34140","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.702110Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34154","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.712108Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34182","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.720118Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34196","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.730057Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34208","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.740553Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34234","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.755000Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34254","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.765936Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34282","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.774536Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34290","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.783311Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34314","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.791755Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34326","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.802881Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34346","server-name":"","error":"read tcp 127.0.0.1:2379->127.0.0.1:34346: read: connection reset by peer"} {"level":"warn","ts":"2026-05-20T20:55:57.839383Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34374","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.848604Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34390","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.859965Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34402","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.871058Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34422","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.879606Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34444","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.888990Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34458","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.898306Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34466","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.911376Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34486","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.921271Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34498","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.930808Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34506","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.940037Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34524","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.947861Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34542","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.956118Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34560","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.963843Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34586","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.975111Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34612","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.981743Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34638","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:57.990220Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34654","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.003510Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34668","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.020355Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34698","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.030623Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34704","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.036843Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34732","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.046127Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34754","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.054758Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34776","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.064561Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34794","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.075277Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34824","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.089104Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34854","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.099099Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34868","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.108451Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34894","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.124365Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34896","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.130853Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34912","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.139462Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34916","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.149399Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34934","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.165683Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34954","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.171370Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34984","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.178837Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34990","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.186367Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34998","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.236036Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35016","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.245354Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35036","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.256665Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35062","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:58.307148Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35064","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:55:59.221552Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.185953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/controller\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T20:55:59.221641Z","caller":"traceutil/trace.go:172","msg":"trace[911897946] range","detail":"{range_begin:/registry/csinodes/controller; range_end:; response_count:0; response_revision:43; }","duration":"101.292634ms","start":"2026-05-20T20:55:59.120331Z","end":"2026-05-20T20:55:59.221624Z","steps":["trace[911897946] 'agreement among raft nodes before linearized reading' (duration: 62.829522ms)","trace[911897946] 'range keys from in-memory index tree' (duration: 38.318879ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:55:59.222033Z","caller":"traceutil/trace.go:172","msg":"trace[1255480866] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"123.665479ms","start":"2026-05-20T20:55:59.098342Z","end":"2026-05-20T20:55:59.222007Z","steps":["trace[1255480866] 'process raft request' (duration: 123.611628ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:55:59.222190Z","caller":"traceutil/trace.go:172","msg":"trace[901185711] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"128.100963ms","start":"2026-05-20T20:55:59.094076Z","end":"2026-05-20T20:55:59.222177Z","steps":["trace[901185711] 'process raft request' (duration: 89.092184ms)","trace[901185711] 'compare' (duration: 38.637954ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:56:00.618942Z","caller":"traceutil/trace.go:172","msg":"trace[76536222] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"168.112082ms","start":"2026-05-20T20:56:00.450807Z","end":"2026-05-20T20:56:00.618919Z","steps":["trace[76536222] 'process raft request' (duration: 164.460188ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:00.677268Z","caller":"traceutil/trace.go:172","msg":"trace[159369620] transaction","detail":"{read_only:false; response_revision:124; number_of_response:1; }","duration":"220.998871ms","start":"2026-05-20T20:56:00.456242Z","end":"2026-05-20T20:56:00.677241Z","steps":["trace[159369620] 'process raft request' (duration: 220.792789ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:03.938606Z","caller":"traceutil/trace.go:172","msg":"trace[56732020] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"122.1881ms","start":"2026-05-20T20:56:03.816388Z","end":"2026-05-20T20:56:03.938576Z","steps":["trace[56732020] 'process raft request' (duration: 62.014146ms)","trace[56732020] 'compare' (duration: 59.912541ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:56:04.137739Z","caller":"traceutil/trace.go:172","msg":"trace[241204475] linearizableReadLoop","detail":"{readStateIndex:304; appliedIndex:304; }","duration":"196.222514ms","start":"2026-05-20T20:56:03.941495Z","end":"2026-05-20T20:56:04.137717Z","steps":["trace[241204475] 'read index received' (duration: 196.214814ms)","trace[241204475] 'applied index is now lower than readState.Index' (duration: 6.73µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:56:04.190821Z","caller":"traceutil/trace.go:172","msg":"trace[594909020] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"252.394264ms","start":"2026-05-20T20:56:03.938408Z","end":"2026-05-20T20:56:04.190803Z","steps":["trace[594909020] 'process raft request' (duration: 199.480962ms)","trace[594909020] 'compare' (duration: 52.801491ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:04.190968Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"249.413319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-20T20:56:04.191417Z","caller":"traceutil/trace.go:172","msg":"trace[1995434626] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:298; }","duration":"249.915444ms","start":"2026-05-20T20:56:03.941483Z","end":"2026-05-20T20:56:04.191398Z","steps":["trace[1995434626] 'agreement among raft nodes before linearized reading' (duration: 196.331175ms)","trace[1995434626] 'range keys from in-memory index tree' (duration: 52.878692ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:04.193495Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"250.36302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/controller\" limit:1 ","response":"range_response_count:1 size:542"} {"level":"info","ts":"2026-05-20T20:56:04.193533Z","caller":"traceutil/trace.go:172","msg":"trace[291754174] range","detail":"{range_begin:/registry/leases/kube-node-lease/controller; range_end:; response_count:1; response_revision:299; }","duration":"250.40185ms","start":"2026-05-20T20:56:03.943124Z","end":"2026-05-20T20:56:04.193526Z","steps":["trace[291754174] 'agreement among raft nodes before linearized reading' (duration: 250.319359ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:04.193954Z","caller":"traceutil/trace.go:172","msg":"trace[163102185] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"128.643944ms","start":"2026-05-20T20:56:04.065302Z","end":"2026-05-20T20:56:04.193946Z","steps":["trace[163102185] 'process raft request' (duration: 128.393181ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:04.194055Z","caller":"traceutil/trace.go:172","msg":"trace[475869603] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"128.657114ms","start":"2026-05-20T20:56:04.065392Z","end":"2026-05-20T20:56:04.194049Z","steps":["trace[475869603] 'process raft request' (duration: 128.33488ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:04.194141Z","caller":"traceutil/trace.go:172","msg":"trace[24022320] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"127.795234ms","start":"2026-05-20T20:56:04.066337Z","end":"2026-05-20T20:56:04.194132Z","steps":["trace[24022320] 'process raft request' (duration: 127.409519ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:04.194219Z","caller":"traceutil/trace.go:172","msg":"trace[323369233] transaction","detail":"{read_only:false; number_of_response:0; response_revision:303; }","duration":"127.736204ms","start":"2026-05-20T20:56:04.066478Z","end":"2026-05-20T20:56:04.194214Z","steps":["trace[323369233] 'process raft request' (duration: 127.284379ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:04.194237Z","caller":"traceutil/trace.go:172","msg":"trace[554690808] transaction","detail":"{read_only:false; number_of_response:0; response_revision:300; }","duration":"128.931758ms","start":"2026-05-20T20:56:04.065291Z","end":"2026-05-20T20:56:04.194223Z","steps":["trace[554690808] 'process raft request' (duration: 128.389372ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:04.195014Z","caller":"traceutil/trace.go:172","msg":"trace[438121223] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"251.828457ms","start":"2026-05-20T20:56:03.943144Z","end":"2026-05-20T20:56:04.194973Z","steps":["trace[438121223] 'process raft request' (duration: 250.497161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:04.195777Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"199.824956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:04.196404Z","caller":"traceutil/trace.go:172","msg":"trace[1616402737] range","detail":"{range_begin:/registry/resourceslices; range_end:; response_count:0; response_revision:303; }","duration":"201.810399ms","start":"2026-05-20T20:56:03.994172Z","end":"2026-05-20T20:56:04.195982Z","steps":["trace[1616402737] 'agreement among raft nodes before linearized reading' (duration: 199.758575ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:05.090934Z","caller":"traceutil/trace.go:172","msg":"trace[893985654] transaction","detail":"{read_only:false; number_of_response:0; response_revision:327; }","duration":"107.383689ms","start":"2026-05-20T20:56:04.983527Z","end":"2026-05-20T20:56:05.090911Z","steps":["trace[893985654] 'process raft request' (duration: 107.301118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:05.197484Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"105.116559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-controller\" limit:1 ","response":"range_response_count:1 size:6077"} {"level":"info","ts":"2026-05-20T20:56:05.197520Z","caller":"traceutil/trace.go:172","msg":"trace[563048999] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-controller; range_end:; response_count:1; response_revision:327; }","duration":"105.17471ms","start":"2026-05-20T20:56:05.092339Z","end":"2026-05-20T20:56:05.197514Z","steps":["trace[563048999] 'agreement among raft nodes before linearized reading' (duration: 105.006468ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:05.197540Z","caller":"traceutil/trace.go:172","msg":"trace[1170658978] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"196.07573ms","start":"2026-05-20T20:56:05.001444Z","end":"2026-05-20T20:56:05.197520Z","steps":["trace[1170658978] 'process raft request' (duration: 196.03207ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:05.197871Z","caller":"traceutil/trace.go:172","msg":"trace[1739167360] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"204.063042ms","start":"2026-05-20T20:56:04.993798Z","end":"2026-05-20T20:56:05.197861Z","steps":["trace[1739167360] 'process raft request' (duration: 203.615237ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:05.197905Z","caller":"traceutil/trace.go:172","msg":"trace[2130820640] transaction","detail":"{read_only:false; number_of_response:0; response_revision:327; }","duration":"213.57936ms","start":"2026-05-20T20:56:04.984319Z","end":"2026-05-20T20:56:05.197898Z","steps":["trace[2130820640] 'process raft request' (duration: 212.970583ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:05.197961Z","caller":"traceutil/trace.go:172","msg":"trace[948049919] transaction","detail":"{read_only:false; number_of_response:0; response_revision:327; }","duration":"213.511029ms","start":"2026-05-20T20:56:04.984445Z","end":"2026-05-20T20:56:05.197956Z","steps":["trace[948049919] 'process raft request' (duration: 212.924412ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:05.198021Z","caller":"traceutil/trace.go:172","msg":"trace[307642311] transaction","detail":"{read_only:false; number_of_response:0; response_revision:327; }","duration":"213.591149ms","start":"2026-05-20T20:56:04.984424Z","end":"2026-05-20T20:56:05.198015Z","steps":["trace[307642311] 'process raft request' (duration: 212.967123ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:05.197290Z","caller":"traceutil/trace.go:172","msg":"trace[497236216] linearizableReadLoop","detail":"{readStateIndex:337; appliedIndex:337; }","duration":"104.895486ms","start":"2026-05-20T20:56:05.092346Z","end":"2026-05-20T20:56:05.197241Z","steps":["trace[497236216] 'read index received' (duration: 104.885626ms)","trace[497236216] 'applied index is now lower than readState.Index' (duration: 8.1µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:05.623189Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"170.870637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T20:56:05.623292Z","caller":"traceutil/trace.go:172","msg":"trace[114329333] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:334; }","duration":"170.984748ms","start":"2026-05-20T20:56:05.452284Z","end":"2026-05-20T20:56:05.623268Z","steps":["trace[114329333] 'agreement among raft nodes before linearized reading' (duration: 47.536373ms)","trace[114329333] 'range keys from in-memory index tree' (duration: 123.115871ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:05.623590Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"123.156892ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:56:05.623757Z","caller":"traceutil/trace.go:172","msg":"trace[776330364] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"300.097256ms","start":"2026-05-20T20:56:05.323648Z","end":"2026-05-20T20:56:05.623746Z","steps":["trace[776330364] 'process raft request' (duration: 300.062386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:05.623812Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:05.323622Z","time spent":"300.167087ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:05.623894Z","caller":"traceutil/trace.go:172","msg":"trace[774893688] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"326.754276ms","start":"2026-05-20T20:56:05.297125Z","end":"2026-05-20T20:56:05.623879Z","steps":["trace[774893688] 'process raft request' (duration: 202.799365ms)","trace[774893688] 'compare' (duration: 123.05301ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:05.624000Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:05.297111Z","time spent":"326.824596ms","remote":"127.0.0.1:34306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7340,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:05.624024Z","caller":"traceutil/trace.go:172","msg":"trace[725961984] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"322.337046ms","start":"2026-05-20T20:56:05.301681Z","end":"2026-05-20T20:56:05.624018Z","steps":["trace[725961984] 'process raft request' (duration: 321.988863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:05.624057Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:05.301668Z","time spent":"322.373147ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:05.624152Z","caller":"traceutil/trace.go:172","msg":"trace[778231377] linearizableReadLoop","detail":"{readStateIndex:348; appliedIndex:347; }","duration":"102.533491ms","start":"2026-05-20T20:56:05.521608Z","end":"2026-05-20T20:56:05.624142Z","steps":["trace[778231377] 'read index received' (duration: 95.723704ms)","trace[778231377] 'applied index is now lower than readState.Index' (duration: 6.808637ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:05.624251Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"102.635992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T20:56:05.624283Z","caller":"traceutil/trace.go:172","msg":"trace[1113796511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:337; }","duration":"102.669382ms","start":"2026-05-20T20:56:05.521605Z","end":"2026-05-20T20:56:05.624275Z","steps":["trace[1113796511] 'agreement among raft nodes before linearized reading' (duration: 102.577151ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:05.980093Z","caller":"traceutil/trace.go:172","msg":"trace[896877286] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"178.051878ms","start":"2026-05-20T20:56:05.802017Z","end":"2026-05-20T20:56:05.980069Z","steps":["trace[896877286] 'process raft request' (duration: 114.431184ms)","trace[896877286] 'compare' (duration: 63.459692ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:05.980121Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"228.330082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" limit:1 ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-20T20:56:05.980214Z","caller":"traceutil/trace.go:172","msg":"trace[413601695] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:341; }","duration":"228.452913ms","start":"2026-05-20T20:56:05.751742Z","end":"2026-05-20T20:56:05.980195Z","steps":["trace[413601695] 'range keys from in-memory index tree' (duration: 228.221921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:08.859095Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683028861,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T20:56:09.136285Z","caller":"traceutil/trace.go:172","msg":"trace[1151207814] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:372; }","duration":"778.047103ms","start":"2026-05-20T20:56:08.358202Z","end":"2026-05-20T20:56:09.136249Z","steps":["trace[1151207814] 'read index received' (duration: 778.036963ms)","trace[1151207814] 'applied index is now lower than readState.Index' (duration: 8.31µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:09.136683Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"734.471594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 ","response":"range_response_count:1 size:238"} {"level":"info","ts":"2026-05-20T20:56:09.137230Z","caller":"traceutil/trace.go:172","msg":"trace[43068415] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner; range_end:; response_count:1; response_revision:360; }","duration":"735.05707ms","start":"2026-05-20T20:56:08.402165Z","end":"2026-05-20T20:56:09.137222Z","steps":["trace[43068415] 'agreement among raft nodes before linearized reading' (duration: 734.344123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.137349Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"534.654744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-05-20T20:56:09.137366Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"685.641158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-20T20:56:09.137454Z","caller":"traceutil/trace.go:172","msg":"trace[310270452] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:360; }","duration":"534.777955ms","start":"2026-05-20T20:56:08.602654Z","end":"2026-05-20T20:56:09.137432Z","steps":["trace[310270452] 'agreement among raft nodes before linearized reading' (duration: 534.509672ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:09.137492Z","caller":"traceutil/trace.go:172","msg":"trace[236423464] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:360; }","duration":"685.725909ms","start":"2026-05-20T20:56:08.451714Z","end":"2026-05-20T20:56:09.137440Z","steps":["trace[236423464] 'agreement among raft nodes before linearized reading' (duration: 685.400076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.136786Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"434.516846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-05-20T20:56:09.137517Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.602600Z","time spent":"534.898287ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:09.137566Z","caller":"traceutil/trace.go:172","msg":"trace[1565916297] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-cidrs-controller; range_end:; response_count:1; response_revision:360; }","duration":"435.294784ms","start":"2026-05-20T20:56:08.702237Z","end":"2026-05-20T20:56:09.137532Z","steps":["trace[1565916297] 'agreement among raft nodes before linearized reading' (duration: 434.391805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.136856Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"778.664379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-20T20:56:09.137604Z","caller":"traceutil/trace.go:172","msg":"trace[860671222] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:360; }","duration":"779.410817ms","start":"2026-05-20T20:56:08.358184Z","end":"2026-05-20T20:56:09.137595Z","steps":["trace[860671222] 'agreement among raft nodes before linearized reading' (duration: 778.247125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.136960Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"284.395032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-05-20T20:56:09.137567Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.451681Z","time spent":"685.846021ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:09.137684Z","caller":"traceutil/trace.go:172","msg":"trace[1201958496] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:360; }","duration":"285.125039ms","start":"2026-05-20T20:56:08.852551Z","end":"2026-05-20T20:56:09.137676Z","steps":["trace[1201958496] 'agreement among raft nodes before linearized reading' (duration: 284.289901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.137471Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.402138Z","time spent":"735.188561ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":260,"request content":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:09.137605Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.702208Z","time spent":"435.387695ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:09.137010Z","caller":"traceutil/trace.go:172","msg":"trace[1562599247] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"826.528614ms","start":"2026-05-20T20:56:08.310463Z","end":"2026-05-20T20:56:09.136992Z","steps":["trace[1562599247] 'process raft request' (duration: 825.861838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.137091Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"585.723893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-20T20:56:09.138403Z","caller":"traceutil/trace.go:172","msg":"trace[567333116] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:360; }","duration":"587.026337ms","start":"2026-05-20T20:56:08.551360Z","end":"2026-05-20T20:56:09.138387Z","steps":["trace[567333116] 'agreement among raft nodes before linearized reading' (duration: 585.685893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.138479Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.551336Z","time spent":"587.122317ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:09.137114Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"635.684432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-05-20T20:56:09.138426Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.310440Z","time spent":"827.630876ms","remote":"127.0.0.1:34134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:56:09.137151Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"485.457954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-20T20:56:09.138962Z","caller":"traceutil/trace.go:172","msg":"trace[2061274270] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:360; }","duration":"487.264364ms","start":"2026-05-20T20:56:08.651687Z","end":"2026-05-20T20:56:09.138951Z","steps":["trace[2061274270] 'agreement among raft nodes before linearized reading' (duration: 485.418484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.137182Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"614.31512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-controller\" limit:1 ","response":"range_response_count:1 size:7355"} {"level":"warn","ts":"2026-05-20T20:56:09.138995Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.651655Z","time spent":"487.328815ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:09.139008Z","caller":"traceutil/trace.go:172","msg":"trace[991994410] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-controller; range_end:; response_count:1; response_revision:360; }","duration":"616.13505ms","start":"2026-05-20T20:56:08.522860Z","end":"2026-05-20T20:56:09.138995Z","steps":["trace[991994410] 'agreement among raft nodes before linearized reading' (duration: 614.27186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.139048Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.522819Z","time spent":"616.215921ms","remote":"127.0.0.1:34306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":7377,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:09.137160Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"234.378143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-20T20:56:09.140249Z","caller":"traceutil/trace.go:172","msg":"trace[439591299] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:360; }","duration":"237.473426ms","start":"2026-05-20T20:56:08.902762Z","end":"2026-05-20T20:56:09.140235Z","steps":["trace[439591299] 'agreement among raft nodes before linearized reading' (duration: 234.223961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.136961Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"334.918575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-20T20:56:09.140426Z","caller":"traceutil/trace.go:172","msg":"trace[1020677986] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:360; }","duration":"338.368161ms","start":"2026-05-20T20:56:08.802035Z","end":"2026-05-20T20:56:09.140403Z","steps":["trace[1020677986] 'agreement among raft nodes before linearized reading' (duration: 334.839144ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.140457Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.802019Z","time spent":"338.426652ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:09.137663Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.358146Z","time spent":"779.508188ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:09.137027Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"385.132256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-20T20:56:09.140644Z","caller":"traceutil/trace.go:172","msg":"trace[1093713651] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:360; }","duration":"388.748324ms","start":"2026-05-20T20:56:08.751889Z","end":"2026-05-20T20:56:09.140637Z","steps":["trace[1093713651] 'agreement among raft nodes before linearized reading' (duration: 385.090085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.140669Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.751864Z","time spent":"388.796854ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:09.139071Z","caller":"traceutil/trace.go:172","msg":"trace[419373421] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:360; }","duration":"637.184157ms","start":"2026-05-20T20:56:08.501414Z","end":"2026-05-20T20:56:09.138598Z","steps":["trace[419373421] 'agreement among raft nodes before linearized reading' (duration: 635.642511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:09.140749Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:08.501384Z","time spent":"639.3585ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:09.645350Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683028864,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:56:10.146355Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683028864,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:56:10.439911Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.29525727s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T20:56:10.440202Z","caller":"traceutil/trace.go:172","msg":"trace[987683894] linearizableReadLoop","detail":"{readStateIndex:373; appliedIndex:373; }","duration":"1.295491523s","start":"2026-05-20T20:56:09.144686Z","end":"2026-05-20T20:56:10.440177Z","steps":["trace[987683894] 'read index received' (duration: 1.295482203s)","trace[987683894] 'applied index is now lower than readState.Index' (duration: 8.21µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:10.440381Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.295677214s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-20T20:56:10.440401Z","caller":"traceutil/trace.go:172","msg":"trace[1059308140] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:360; }","duration":"1.295717125s","start":"2026-05-20T20:56:09.144680Z","end":"2026-05-20T20:56:10.440397Z","steps":["trace[1059308140] 'agreement among raft nodes before linearized reading' (duration: 1.295592224s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.440421Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.144660Z","time spent":"1.295756125s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:10.440611Z","caller":"traceutil/trace.go:172","msg":"trace[771938349] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"1.296109149s","start":"2026-05-20T20:56:09.144478Z","end":"2026-05-20T20:56:10.440587Z","steps":["trace[771938349] 'process raft request' (duration: 1.295884547s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.440761Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.144438Z","time spent":"1.29625684s","remote":"127.0.0.1:34134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:10.788630Z","caller":"traceutil/trace.go:172","msg":"trace[1037691142] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:374; }","duration":"348.34365ms","start":"2026-05-20T20:56:10.440249Z","end":"2026-05-20T20:56:10.788593Z","steps":["trace[1037691142] 'read index received' (duration: 348.297569ms)","trace[1037691142] 'applied index is now lower than readState.Index' (duration: 44.101µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:10.795248Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.650481451s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-05-20T20:56:10.795291Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.592631928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-20T20:56:10.795336Z","caller":"traceutil/trace.go:172","msg":"trace[18237285] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:361; }","duration":"1.650590523s","start":"2026-05-20T20:56:09.144727Z","end":"2026-05-20T20:56:10.795317Z","steps":["trace[18237285] 'agreement among raft nodes before linearized reading' (duration: 1.644005154s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:10.795366Z","caller":"traceutil/trace.go:172","msg":"trace[1435482177] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:361; }","duration":"1.592726819s","start":"2026-05-20T20:56:09.202621Z","end":"2026-05-20T20:56:10.795348Z","steps":["trace[1435482177] 'agreement among raft nodes before linearized reading' (duration: 1.586081059s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.795380Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.144724Z","time spent":"1.650644823s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:10.795407Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.202602Z","time spent":"1.592795509s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:10.795445Z","caller":"traceutil/trace.go:172","msg":"trace[944899236] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"1.647826754s","start":"2026-05-20T20:56:09.147603Z","end":"2026-05-20T20:56:10.795430Z","steps":["trace[944899236] 'process raft request' (duration: 1.641073983s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.795412Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.44208205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-20T20:56:10.796794Z","caller":"traceutil/trace.go:172","msg":"trace[1419735038] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"1.648622621s","start":"2026-05-20T20:56:09.148155Z","end":"2026-05-20T20:56:10.796777Z","steps":["trace[1419735038] 'process raft request' (duration: 1.64854615s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:10.796828Z","caller":"traceutil/trace.go:172","msg":"trace[446230471] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"1.649072966s","start":"2026-05-20T20:56:09.147742Z","end":"2026-05-20T20:56:10.796815Z","steps":["trace[446230471] 'process raft request' (duration: 1.647664861s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:10.796798Z","caller":"traceutil/trace.go:172","msg":"trace[41245599] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"1.649017795s","start":"2026-05-20T20:56:09.147759Z","end":"2026-05-20T20:56:10.796777Z","steps":["trace[41245599] 'process raft request' (duration: 1.648877434s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:10.797129Z","caller":"traceutil/trace.go:172","msg":"trace[2145498948] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"1.647764203s","start":"2026-05-20T20:56:09.149354Z","end":"2026-05-20T20:56:10.797118Z","steps":["trace[2145498948] 'process raft request' (duration: 1.647391739s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.797187Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.149343Z","time spent":"1.647818884s","remote":"127.0.0.1:34628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2299,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:10.795519Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.643889982s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-05-20T20:56:10.797142Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.147739Z","time spent":"1.649301348s","remote":"127.0.0.1:34306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7340,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:10.796943Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.147727Z","time spent":"1.649133316s","remote":"127.0.0.1:34256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":697,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:10.797258Z","caller":"traceutil/trace.go:172","msg":"trace[1590487295] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"1.142910173s","start":"2026-05-20T20:56:09.654328Z","end":"2026-05-20T20:56:10.797238Z","steps":["trace[1590487295] 'process raft request' (duration: 1.142806541s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:10.797353Z","caller":"traceutil/trace.go:172","msg":"trace[304909558] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"1.457012109s","start":"2026-05-20T20:56:09.340294Z","end":"2026-05-20T20:56:10.797306Z","steps":["trace[304909558] 'process raft request' (duration: 1.456802315s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.796417Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.651635383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 ","response":"range_response_count:1 size:238"} {"level":"warn","ts":"2026-05-20T20:56:10.797440Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.340286Z","time spent":"1.457112919s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:10.797502Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.654304Z","time spent":"1.143107605s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:10.796426Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.494963261s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-20T20:56:10.797479Z","caller":"traceutil/trace.go:172","msg":"trace[46945454] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner; range_end:; response_count:1; response_revision:361; }","duration":"1.652697115s","start":"2026-05-20T20:56:09.144756Z","end":"2026-05-20T20:56:10.797453Z","steps":["trace[46945454] 'agreement among raft nodes before linearized reading' (duration: 1.643959153s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:10.797579Z","caller":"traceutil/trace.go:172","msg":"trace[218979402] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:361; }","duration":"1.496117283s","start":"2026-05-20T20:56:09.301452Z","end":"2026-05-20T20:56:10.797569Z","steps":["trace[218979402] 'agreement among raft nodes before linearized reading' (duration: 1.487190529s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.797612Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.144754Z","time spent":"1.652838516s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":260,"request content":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:10.797654Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.301434Z","time spent":"1.496183514s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:10.796491Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.543540376s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-20T20:56:10.797722Z","caller":"traceutil/trace.go:172","msg":"trace[155203542] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-cidrs-controller; range_end:; response_count:1; response_revision:361; }","duration":"1.5447649s","start":"2026-05-20T20:56:09.252944Z","end":"2026-05-20T20:56:10.797709Z","steps":["trace[155203542] 'agreement among raft nodes before linearized reading' (duration: 1.535750105s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.797773Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.252860Z","time spent":"1.544896841s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:10.796498Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.651753924s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-20T20:56:10.797823Z","caller":"traceutil/trace.go:172","msg":"trace[1565293237] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:361; }","duration":"1.653073669s","start":"2026-05-20T20:56:09.144739Z","end":"2026-05-20T20:56:10.797813Z","steps":["trace[1565293237] 'agreement among raft nodes before linearized reading' (duration: 1.643983043s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.796518Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.059797761s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-20T20:56:10.797862Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.144736Z","time spent":"1.653113909s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:10.796546Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.128857534s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T20:56:10.797940Z","caller":"traceutil/trace.go:172","msg":"trace[2027532040] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:361; }","duration":"1.444627857s","start":"2026-05-20T20:56:09.353293Z","end":"2026-05-20T20:56:10.797921Z","steps":["trace[2027532040] 'agreement among raft nodes before linearized reading' (duration: 1.43538505s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.798049Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.353272Z","time spent":"1.444761288s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:10.797867Z","caller":"traceutil/trace.go:172","msg":"trace[1037072178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:361; }","duration":"1.061146495s","start":"2026-05-20T20:56:09.736712Z","end":"2026-05-20T20:56:10.797858Z","steps":["trace[1037072178] 'agreement among raft nodes before linearized reading' (duration: 1.051998749s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.798325Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.736685Z","time spent":"1.06162191s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:10.797954Z","caller":"traceutil/trace.go:172","msg":"trace[1330591339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:361; }","duration":"1.130263809s","start":"2026-05-20T20:56:09.667682Z","end":"2026-05-20T20:56:10.797946Z","steps":["trace[1330591339] 'agreement among raft nodes before linearized reading' (duration: 1.121008472s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.798409Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.667654Z","time spent":"1.130739524s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:10.795574Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.147474Z","time spent":"1.648033745s","remote":"127.0.0.1:34628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2194,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:10.797335Z","caller":"traceutil/trace.go:172","msg":"trace[1007903621] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"1.497318186s","start":"2026-05-20T20:56:09.300007Z","end":"2026-05-20T20:56:10.797325Z","steps":["trace[1007903621] 'process raft request' (duration: 1.496934551s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.798646Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.299975Z","time spent":"1.49863163s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:10.796439Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.393061698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-20T20:56:10.798730Z","caller":"traceutil/trace.go:172","msg":"trace[40932257] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"352.18954ms","start":"2026-05-20T20:56:10.446527Z","end":"2026-05-20T20:56:10.798716Z","steps":["trace[40932257] 'process raft request' (duration: 352.151049ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:10.798768Z","caller":"traceutil/trace.go:172","msg":"trace[40458127] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:361; }","duration":"1.395418963s","start":"2026-05-20T20:56:09.403337Z","end":"2026-05-20T20:56:10.798756Z","steps":["trace[40458127] 'agreement among raft nodes before linearized reading' (duration: 1.385333858s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.798793Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.446502Z","time spent":"352.262641ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:56:10.798805Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.403322Z","time spent":"1.395473784s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:10.796989Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.148134Z","time spent":"1.648719982s","remote":"127.0.0.1:34628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:10.797273Z","caller":"traceutil/trace.go:172","msg":"trace[441455223] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:361; }","duration":"1.645631001s","start":"2026-05-20T20:56:09.151595Z","end":"2026-05-20T20:56:10.797226Z","steps":["trace[441455223] 'agreement among raft nodes before linearized reading' (duration: 1.637098621s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.799260Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:09.151585Z","time spent":"1.647661871s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:10.798945Z","caller":"traceutil/trace.go:172","msg":"trace[1778573175] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"353.810847ms","start":"2026-05-20T20:56:10.445125Z","end":"2026-05-20T20:56:10.798936Z","steps":["trace[1778573175] 'process raft request' (duration: 353.497124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:10.799411Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.445099Z","time spent":"354.248421ms","remote":"127.0.0.1:34134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:56:11.346839Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"477.825511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-20T20:56:11.346883Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"421.665353ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:56:11.346928Z","caller":"traceutil/trace.go:172","msg":"trace[2014474338] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:386; }","duration":"477.935552ms","start":"2026-05-20T20:56:10.868971Z","end":"2026-05-20T20:56:11.346906Z","steps":["trace[2014474338] 'agreement among raft nodes before linearized reading' (duration: 56.083038ms)","trace[2014474338] 'range keys from in-memory index tree' (duration: 421.611002ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:11.347013Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.868943Z","time spent":"478.054503ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:11.347064Z","caller":"traceutil/trace.go:172","msg":"trace[1539114490] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"508.074828ms","start":"2026-05-20T20:56:10.838946Z","end":"2026-05-20T20:56:11.347020Z","steps":["trace[1539114490] 'process raft request' (duration: 86.187693ms)","trace[1539114490] 'compare' (duration: 421.501262ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:11.347236Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.838901Z","time spent":"508.25801ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:56:11.347265Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"427.687086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 ","response":"range_response_count:1 size:4942"} {"level":"info","ts":"2026-05-20T20:56:11.347301Z","caller":"traceutil/trace.go:172","msg":"trace[551326410] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-controller; range_end:; response_count:1; response_revision:389; }","duration":"427.737686ms","start":"2026-05-20T20:56:10.919554Z","end":"2026-05-20T20:56:11.347292Z","steps":["trace[551326410] 'agreement among raft nodes before linearized reading' (duration: 427.574244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:11.347330Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.919521Z","time spent":"427.800597ms","remote":"127.0.0.1:34306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":4964,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:11.347514Z","caller":"traceutil/trace.go:172","msg":"trace[488025459] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"472.050421ms","start":"2026-05-20T20:56:10.875430Z","end":"2026-05-20T20:56:11.347481Z","steps":["trace[488025459] 'process raft request' (duration: 471.827399ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:11.347071Z","caller":"traceutil/trace.go:172","msg":"trace[1896944347] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:399; }","duration":"422.021147ms","start":"2026-05-20T20:56:10.925027Z","end":"2026-05-20T20:56:11.347048Z","steps":["trace[1896944347] 'read index received' (duration: 393.765734ms)","trace[1896944347] 'applied index is now lower than readState.Index' (duration: 28.253583ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:11.347604Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.875382Z","time spent":"472.176982ms","remote":"127.0.0.1:34628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3742,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:11.347639Z","caller":"traceutil/trace.go:172","msg":"trace[1324186516] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"474.394894ms","start":"2026-05-20T20:56:10.873232Z","end":"2026-05-20T20:56:11.347627Z","steps":["trace[1324186516] 'process raft request' (duration: 473.91872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:11.347704Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.873224Z","time spent":"474.441855ms","remote":"127.0.0.1:34064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:11.347719Z","caller":"traceutil/trace.go:172","msg":"trace[1558465524] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"472.99951ms","start":"2026-05-20T20:56:10.874704Z","end":"2026-05-20T20:56:11.347704Z","steps":["trace[1558465524] 'process raft request' (duration: 472.514305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:11.347799Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.874697Z","time spent":"473.055691ms","remote":"127.0.0.1:34430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2394,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:11.347892Z","caller":"traceutil/trace.go:172","msg":"trace[1860353472] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"474.644147ms","start":"2026-05-20T20:56:10.873238Z","end":"2026-05-20T20:56:11.347882Z","steps":["trace[1860353472] 'process raft request' (duration: 473.94616ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:11.347965Z","caller":"traceutil/trace.go:172","msg":"trace[753207762] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"474.814959ms","start":"2026-05-20T20:56:10.873139Z","end":"2026-05-20T20:56:11.347954Z","steps":["trace[753207762] 'process raft request' (duration: 473.89172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:11.347938Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.873121Z","time spent":"474.792668ms","remote":"127.0.0.1:34530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:11.348050Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.873121Z","time spent":"474.891789ms","remote":"127.0.0.1:34880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3973,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:11.349190Z","caller":"traceutil/trace.go:172","msg":"trace[208198544] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"477.116124ms","start":"2026-05-20T20:56:10.872046Z","end":"2026-05-20T20:56:11.349162Z","steps":["trace[208198544] 'process raft request' (duration: 474.931501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:11.349322Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:10.872024Z","time spent":"477.239995ms","remote":"127.0.0.1:34306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3360,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:56:11.564159Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"207.842809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" limit:1 ","response":"range_response_count:1 size:3988"} {"level":"info","ts":"2026-05-20T20:56:11.564248Z","caller":"traceutil/trace.go:172","msg":"trace[1664823073] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:394; }","duration":"207.94413ms","start":"2026-05-20T20:56:11.356279Z","end":"2026-05-20T20:56:11.564223Z","steps":["trace[1664823073] 'agreement among raft nodes before linearized reading' (duration: 177.798159ms)","trace[1664823073] 'range keys from in-memory index tree' (duration: 29.912428ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:56:11.564240Z","caller":"traceutil/trace.go:172","msg":"trace[2009724981] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"209.354425ms","start":"2026-05-20T20:56:11.354856Z","end":"2026-05-20T20:56:11.564211Z","steps":["trace[2009724981] 'process raft request' (duration: 179.285765ms)","trace[2009724981] 'compare' (duration: 29.836068ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:56:11.564451Z","caller":"traceutil/trace.go:172","msg":"trace[797999364] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"206.232542ms","start":"2026-05-20T20:56:11.358199Z","end":"2026-05-20T20:56:11.564431Z","steps":["trace[797999364] 'process raft request' (duration: 205.97246ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:11.564261Z","caller":"traceutil/trace.go:172","msg":"trace[1658840728] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"203.656775ms","start":"2026-05-20T20:56:11.360585Z","end":"2026-05-20T20:56:11.564242Z","steps":["trace[1658840728] 'process raft request' (duration: 203.620475ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:11.564595Z","caller":"traceutil/trace.go:172","msg":"trace[1298641123] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"207.051581ms","start":"2026-05-20T20:56:11.357525Z","end":"2026-05-20T20:56:11.564576Z","steps":["trace[1298641123] 'process raft request' (duration: 206.588456ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:11.630800Z","caller":"traceutil/trace.go:172","msg":"trace[181873133] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"181.951622ms","start":"2026-05-20T20:56:11.448803Z","end":"2026-05-20T20:56:11.630755Z","steps":["trace[181873133] 'process raft request' (duration: 181.83719ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:11.822748Z","caller":"traceutil/trace.go:172","msg":"trace[1372817254] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"250.615683ms","start":"2026-05-20T20:56:11.572114Z","end":"2026-05-20T20:56:11.822730Z","steps":["trace[1372817254] 'process raft request' (duration: 250.555922ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:11.822780Z","caller":"traceutil/trace.go:172","msg":"trace[101139674] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"253.576803ms","start":"2026-05-20T20:56:11.569177Z","end":"2026-05-20T20:56:11.822753Z","steps":["trace[101139674] 'process raft request' (duration: 181.191584ms)","trace[101139674] 'compare' (duration: 72.175557ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:56:11.839108Z","caller":"traceutil/trace.go:172","msg":"trace[2052565815] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"203.202291ms","start":"2026-05-20T20:56:11.635882Z","end":"2026-05-20T20:56:11.839084Z","steps":["trace[2052565815] 'process raft request' (duration: 202.872028ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:11.840017Z","caller":"traceutil/trace.go:172","msg":"trace[406334914] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"195.584763ms","start":"2026-05-20T20:56:11.644414Z","end":"2026-05-20T20:56:11.839998Z","steps":["trace[406334914] 'process raft request' (duration: 195.530173ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:11.840224Z","caller":"traceutil/trace.go:172","msg":"trace[866244832] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"201.1004ms","start":"2026-05-20T20:56:11.639059Z","end":"2026-05-20T20:56:11.840160Z","steps":["trace[866244832] 'process raft request' (duration: 200.824317ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:11.840024Z","caller":"traceutil/trace.go:172","msg":"trace[1207829289] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"201.590815ms","start":"2026-05-20T20:56:11.638415Z","end":"2026-05-20T20:56:11.840006Z","steps":["trace[1207829289] 'process raft request' (duration: 201.366433ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:21.353277Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683028997,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T20:56:21.563129Z","caller":"traceutil/trace.go:172","msg":"trace[756235989] linearizableReadLoop","detail":"{readStateIndex:457; appliedIndex:457; }","duration":"710.215856ms","start":"2026-05-20T20:56:20.852587Z","end":"2026-05-20T20:56:21.562802Z","steps":["trace[756235989] 'read index received' (duration: 710.205096ms)","trace[756235989] 'applied index is now lower than readState.Index' (duration: 9.45µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:21.563267Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"710.437178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T20:56:21.563770Z","caller":"traceutil/trace.go:172","msg":"trace[612096511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:441; }","duration":"710.911962ms","start":"2026-05-20T20:56:20.852561Z","end":"2026-05-20T20:56:21.563473Z","steps":["trace[612096511] 'agreement among raft nodes before linearized reading' (duration: 710.387517ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:21.564384Z","caller":"traceutil/trace.go:172","msg":"trace[24615338] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"721.127668ms","start":"2026-05-20T20:56:20.842557Z","end":"2026-05-20T20:56:21.563685Z","steps":["trace[24615338] 'process raft request' (duration: 720.511562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:21.565095Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:20.842526Z","time spent":"722.49117ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:21.564822Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:20.852471Z","time spent":"711.84545ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:21.605274Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"723.326984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T20:56:21.605332Z","caller":"traceutil/trace.go:172","msg":"trace[1976747604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:442; }","duration":"723.388024ms","start":"2026-05-20T20:56:20.881930Z","end":"2026-05-20T20:56:21.605318Z","steps":["trace[1976747604] 'agreement among raft nodes before linearized reading' (duration: 723.242233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:21.605378Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:20.881916Z","time spent":"723.447665ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:21.605442Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"600.920794ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:21.605503Z","caller":"traceutil/trace.go:172","msg":"trace[381982900] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:442; }","duration":"600.981595ms","start":"2026-05-20T20:56:21.004506Z","end":"2026-05-20T20:56:21.605487Z","steps":["trace[381982900] 'agreement among raft nodes before linearized reading' (duration: 600.893244ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:21.605509Z","caller":"traceutil/trace.go:172","msg":"trace[1464522677] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"736.145093ms","start":"2026-05-20T20:56:20.869342Z","end":"2026-05-20T20:56:21.605487Z","steps":["trace[1464522677] 'process raft request' (duration: 736.094962ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:21.605662Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:20.869323Z","time spent":"736.260323ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:21.605740Z","caller":"traceutil/trace.go:172","msg":"trace[1202718550] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"761.65415ms","start":"2026-05-20T20:56:20.844049Z","end":"2026-05-20T20:56:21.605703Z","steps":["trace[1202718550] 'process raft request' (duration: 761.262407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:21.607067Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:20.844039Z","time spent":"761.743711ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:22.244643Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"239.905397ms","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-05-20T20:56:22.244727Z","caller":"traceutil/trace.go:172","msg":"trace[1362490052] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:445; }","duration":"240.014088ms","start":"2026-05-20T20:56:22.004696Z","end":"2026-05-20T20:56:22.244710Z","steps":["trace[1362490052] 'range keys from in-memory index tree' (duration: 239.835836ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:22.248833Z","caller":"traceutil/trace.go:172","msg":"trace[369607132] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"637.321815ms","start":"2026-05-20T20:56:21.611492Z","end":"2026-05-20T20:56:22.248814Z","steps":["trace[369607132] 'process raft request' (duration: 637.118293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:22.248986Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:21.611464Z","time spent":"637.461906ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:23.867864Z","caller":"traceutil/trace.go:172","msg":"trace[707360500] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"135.448661ms","start":"2026-05-20T20:56:23.732396Z","end":"2026-05-20T20:56:23.867845Z","steps":["trace[707360500] 'process raft request' (duration: 126.085977ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:25.209115Z","caller":"traceutil/trace.go:172","msg":"trace[2140028242] linearizableReadLoop","detail":"{readStateIndex:469; appliedIndex:469; }","duration":"204.777742ms","start":"2026-05-20T20:56:25.004311Z","end":"2026-05-20T20:56:25.209088Z","steps":["trace[2140028242] 'read index received' (duration: 204.770491ms)","trace[2140028242] 'applied index is now lower than readState.Index' (duration: 6.081µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:25.209251Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"204.915793ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:25.209283Z","caller":"traceutil/trace.go:172","msg":"trace[177952264] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:452; }","duration":"204.968283ms","start":"2026-05-20T20:56:25.004306Z","end":"2026-05-20T20:56:25.209274Z","steps":["trace[177952264] 'agreement among raft nodes before linearized reading' (duration: 204.878652ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:25.209702Z","caller":"traceutil/trace.go:172","msg":"trace[692714838] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"427.057428ms","start":"2026-05-20T20:56:24.782632Z","end":"2026-05-20T20:56:25.209690Z","steps":["trace[692714838] 'process raft request' (duration: 426.952257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:25.209810Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:24.782609Z","time spent":"427.139958ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:25.709178Z","caller":"traceutil/trace.go:172","msg":"trace[1960458764] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"133.242139ms","start":"2026-05-20T20:56:25.575912Z","end":"2026-05-20T20:56:25.709154Z","steps":["trace[1960458764] 'process raft request' (duration: 133.080578ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:25.715825Z","caller":"traceutil/trace.go:172","msg":"trace[1822947851] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"134.273808ms","start":"2026-05-20T20:56:25.581530Z","end":"2026-05-20T20:56:25.715804Z","steps":["trace[1822947851] 'process raft request' (duration: 134.101906ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:25.835037Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"112.561477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T20:56:25.835208Z","caller":"traceutil/trace.go:172","msg":"trace[836351463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:456; }","duration":"112.744588ms","start":"2026-05-20T20:56:25.722448Z","end":"2026-05-20T20:56:25.835192Z","steps":["trace[836351463] 'agreement among raft nodes before linearized reading' (duration: 55.630133ms)","trace[836351463] 'range keys from in-memory index tree' (duration: 56.819513ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:56:25.835155Z","caller":"traceutil/trace.go:172","msg":"trace[1427723979] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"118.890573ms","start":"2026-05-20T20:56:25.716243Z","end":"2026-05-20T20:56:25.835134Z","steps":["trace[1427723979] 'process raft request' (duration: 61.926308ms)","trace[1427723979] 'compare' (duration: 56.43794ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:26.139215Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"134.472938ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:56:26.139264Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"104.440815ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:56:26.139337Z","caller":"traceutil/trace.go:172","msg":"trace[2025923962] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:457; }","duration":"134.630499ms","start":"2026-05-20T20:56:26.004686Z","end":"2026-05-20T20:56:26.139316Z","steps":["trace[2025923962] 'range keys from in-memory index tree' (duration: 134.395578ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:26.139392Z","caller":"traceutil/trace.go:172","msg":"trace[439517994] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"298.487569ms","start":"2026-05-20T20:56:25.840883Z","end":"2026-05-20T20:56:26.139370Z","steps":["trace[439517994] 'process raft request' (duration: 193.861582ms)","trace[439517994] 'compare' (duration: 104.256604ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:56:26.182176Z","caller":"traceutil/trace.go:172","msg":"trace[1792786284] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"338.053906ms","start":"2026-05-20T20:56:25.844101Z","end":"2026-05-20T20:56:26.182154Z","steps":["trace[1792786284] 'process raft request' (duration: 337.893904ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:26.182213Z","caller":"traceutil/trace.go:172","msg":"trace[907334310] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"339.691351ms","start":"2026-05-20T20:56:25.842454Z","end":"2026-05-20T20:56:26.182146Z","steps":["trace[907334310] 'process raft request' (duration: 339.364167ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:26.182271Z","caller":"traceutil/trace.go:172","msg":"trace[1032647431] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"338.588871ms","start":"2026-05-20T20:56:25.843650Z","end":"2026-05-20T20:56:26.182239Z","steps":["trace[1032647431] 'process raft request' (duration: 338.297798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:26.182342Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:25.844067Z","time spent":"338.183857ms","remote":"127.0.0.1:34880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:26.182446Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:25.843619Z","time spent":"338.733492ms","remote":"127.0.0.1:34064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:56:26.182489Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:25.842427Z","time spent":"339.969193ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:32.147708Z","caller":"traceutil/trace.go:172","msg":"trace[728102748] linearizableReadLoop","detail":"{readStateIndex:512; appliedIndex:512; }","duration":"142.956808ms","start":"2026-05-20T20:56:32.004672Z","end":"2026-05-20T20:56:32.147629Z","steps":["trace[728102748] 'read index received' (duration: 142.945968ms)","trace[728102748] 'applied index is now lower than readState.Index' (duration: 9.21µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:32.148055Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"143.329341ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:32.148096Z","caller":"traceutil/trace.go:172","msg":"trace[1023244741] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:493; }","duration":"143.425882ms","start":"2026-05-20T20:56:32.004658Z","end":"2026-05-20T20:56:32.148084Z","steps":["trace[1023244741] 'agreement among raft nodes before linearized reading' (duration: 143.296601ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:32.148321Z","caller":"traceutil/trace.go:172","msg":"trace[1037672473] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"356.321637ms","start":"2026-05-20T20:56:31.791975Z","end":"2026-05-20T20:56:32.148297Z","steps":["trace[1037672473] 'process raft request' (duration: 355.900884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:32.148530Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:31.791943Z","time spent":"356.467258ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:32.171003Z","caller":"traceutil/trace.go:172","msg":"trace[934116011] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"303.343572ms","start":"2026-05-20T20:56:31.867644Z","end":"2026-05-20T20:56:32.170987Z","steps":["trace[934116011] 'process raft request' (duration: 303.307531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:32.171161Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:31.867621Z","time spent":"303.439792ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:32.171188Z","caller":"traceutil/trace.go:172","msg":"trace[1826261456] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"376.343053ms","start":"2026-05-20T20:56:31.794822Z","end":"2026-05-20T20:56:32.171165Z","steps":["trace[1826261456] 'process raft request' (duration: 376.032971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:32.171295Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:31.794793Z","time spent":"376.447584ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:42.026032Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683029219,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T20:56:42.106173Z","caller":"traceutil/trace.go:172","msg":"trace[31278254] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:571; }","duration":"580.607943ms","start":"2026-05-20T20:56:41.525532Z","end":"2026-05-20T20:56:42.106139Z","steps":["trace[31278254] 'read index received' (duration: 580.597003ms)","trace[31278254] 'applied index is now lower than readState.Index' (duration: 9.23µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:42.106366Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"580.799925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:42.106423Z","caller":"traceutil/trace.go:172","msg":"trace[646492600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"580.878795ms","start":"2026-05-20T20:56:41.525527Z","end":"2026-05-20T20:56:42.106406Z","steps":["trace[646492600] 'agreement among raft nodes before linearized reading' (duration: 580.757484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.106485Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.525506Z","time spent":"580.966216ms","remote":"127.0.0.1:33960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T20:56:42.106468Z","caller":"traceutil/trace.go:172","msg":"trace[1077376671] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"837.000879ms","start":"2026-05-20T20:56:41.269443Z","end":"2026-05-20T20:56:42.106444Z","steps":["trace[1077376671] 'process raft request' (duration: 836.866068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.106593Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.269409Z","time spent":"837.12307ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:42.239101Z","caller":"traceutil/trace.go:172","msg":"trace[999881315] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:572; }","duration":"132.819577ms","start":"2026-05-20T20:56:42.106255Z","end":"2026-05-20T20:56:42.239074Z","steps":["trace[999881315] 'read index received' (duration: 132.809417ms)","trace[999881315] 'applied index is now lower than readState.Index' (duration: 8.52µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:42.239275Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"235.274659ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:42.239335Z","caller":"traceutil/trace.go:172","msg":"trace[1845149118] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:551; }","duration":"235.389961ms","start":"2026-05-20T20:56:42.003930Z","end":"2026-05-20T20:56:42.239320Z","steps":["trace[1845149118] 'agreement among raft nodes before linearized reading' (duration: 235.278609ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:42.239651Z","caller":"traceutil/trace.go:172","msg":"trace[1919921045] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"967.515629ms","start":"2026-05-20T20:56:41.272124Z","end":"2026-05-20T20:56:42.239640Z","steps":["trace[1919921045] 'process raft request' (duration: 967.028444ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:42.239671Z","caller":"traceutil/trace.go:172","msg":"trace[735511976] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"964.044992ms","start":"2026-05-20T20:56:41.275611Z","end":"2026-05-20T20:56:42.239656Z","steps":["trace[735511976] 'process raft request' (duration: 963.76689ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.239747Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.272113Z","time spent":"967.576369ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:56:42.239751Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.275575Z","time spent":"964.130493ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:42.239884Z","caller":"traceutil/trace.go:172","msg":"trace[1894561168] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"958.548089ms","start":"2026-05-20T20:56:41.281238Z","end":"2026-05-20T20:56:42.239786Z","steps":["trace[1894561168] 'process raft request' (duration: 958.181866ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:42.239960Z","caller":"traceutil/trace.go:172","msg":"trace[498939345] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"948.765972ms","start":"2026-05-20T20:56:41.291142Z","end":"2026-05-20T20:56:42.239908Z","steps":["trace[498939345] 'process raft request' (duration: 948.353859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.240051Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.281211Z","time spent":"958.765081ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:42.240128Z","caller":"traceutil/trace.go:172","msg":"trace[23675783] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"944.955933ms","start":"2026-05-20T20:56:41.295161Z","end":"2026-05-20T20:56:42.240117Z","steps":["trace[23675783] 'process raft request' (duration: 944.57969ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.240146Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.291116Z","time spent":"948.931424ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:56:42.240178Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.295125Z","time spent":"945.033414ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:42.240454Z","caller":"traceutil/trace.go:172","msg":"trace[1189957481] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"931.896371ms","start":"2026-05-20T20:56:41.308550Z","end":"2026-05-20T20:56:42.240446Z","steps":["trace[1189957481] 'process raft request' (duration: 931.69881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.240500Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.308522Z","time spent":"931.962021ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:42.240564Z","caller":"traceutil/trace.go:172","msg":"trace[1470681847] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"924.942927ms","start":"2026-05-20T20:56:41.315606Z","end":"2026-05-20T20:56:42.240549Z","steps":["trace[1470681847] 'process raft request' (duration: 924.829976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.240611Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.315581Z","time spent":"925.009247ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:42.240769Z","caller":"traceutil/trace.go:172","msg":"trace[141817473] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"903.021035ms","start":"2026-05-20T20:56:41.337723Z","end":"2026-05-20T20:56:42.240744Z","steps":["trace[141817473] 'process raft request' (duration: 902.808784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.240849Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.337698Z","time spent":"903.109207ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:42.240399Z","caller":"traceutil/trace.go:172","msg":"trace[1816905525] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"937.668806ms","start":"2026-05-20T20:56:41.302700Z","end":"2026-05-20T20:56:42.240369Z","steps":["trace[1816905525] 'process raft request' (duration: 937.332224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.241027Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.300264Z","time spent":"940.73362ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:42.241136Z","caller":"traceutil/trace.go:172","msg":"trace[346583220] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"897.854915ms","start":"2026-05-20T20:56:41.343270Z","end":"2026-05-20T20:56:42.241125Z","steps":["trace[346583220] 'process raft request' (duration: 897.462062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.241183Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.343241Z","time spent":"897.924575ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:56:42.241213Z","caller":"traceutil/trace.go:172","msg":"trace[1123624207] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"773.78541ms","start":"2026-05-20T20:56:41.467412Z","end":"2026-05-20T20:56:42.241197Z","steps":["trace[1123624207] 'process raft request' (duration: 773.629968ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:42.241404Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:41.467362Z","time spent":"773.935291ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:56:42.246238Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"137.622105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:42.246284Z","caller":"traceutil/trace.go:172","msg":"trace[27242024] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:562; }","duration":"137.670605ms","start":"2026-05-20T20:56:42.108603Z","end":"2026-05-20T20:56:42.246273Z","steps":["trace[27242024] 'agreement among raft nodes before linearized reading' (duration: 137.589744ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:42.247775Z","caller":"traceutil/trace.go:172","msg":"trace[1728302444] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"134.544521ms","start":"2026-05-20T20:56:42.113218Z","end":"2026-05-20T20:56:42.247762Z","steps":["trace[1728302444] 'process raft request' (duration: 134.376579ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:42.247999Z","caller":"traceutil/trace.go:172","msg":"trace[1857442798] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"131.281346ms","start":"2026-05-20T20:56:42.116707Z","end":"2026-05-20T20:56:42.247989Z","steps":["trace[1857442798] 'process raft request' (duration: 131.000043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:46.504859Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683029362,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T20:56:46.548363Z","caller":"traceutil/trace.go:172","msg":"trace[1915610803] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:664; }","duration":"543.737924ms","start":"2026-05-20T20:56:46.004596Z","end":"2026-05-20T20:56:46.548333Z","steps":["trace[1915610803] 'read index received' (duration: 543.728374ms)","trace[1915610803] 'applied index is now lower than readState.Index' (duration: 8.06µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:46.553057Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"548.408969ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:46.553192Z","caller":"traceutil/trace.go:172","msg":"trace[1374415907] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:640; }","duration":"548.57113ms","start":"2026-05-20T20:56:46.004589Z","end":"2026-05-20T20:56:46.553160Z","steps":["trace[1374415907] 'agreement among raft nodes before linearized reading' (duration: 543.919375ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:46.555819Z","caller":"traceutil/trace.go:172","msg":"trace[1204294334] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"842.909745ms","start":"2026-05-20T20:56:45.712877Z","end":"2026-05-20T20:56:46.555787Z","steps":["trace[1204294334] 'process raft request' (duration: 840.112084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:46.556015Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:45.712843Z","time spent":"843.078186ms","remote":"127.0.0.1:34098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:46.569691Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.11185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T20:56:46.569761Z","caller":"traceutil/trace.go:172","msg":"trace[1060796004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:641; }","duration":"106.194111ms","start":"2026-05-20T20:56:46.463553Z","end":"2026-05-20T20:56:46.569747Z","steps":["trace[1060796004] 'agreement among raft nodes before linearized reading' (duration: 106.0535ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:46.569904Z","caller":"traceutil/trace.go:172","msg":"trace[1238893859] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"298.037599ms","start":"2026-05-20T20:56:46.271843Z","end":"2026-05-20T20:56:46.569881Z","steps":["trace[1238893859] 'process raft request' (duration: 297.974739ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:46.569986Z","caller":"traceutil/trace.go:172","msg":"trace[1838634995] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"307.055137ms","start":"2026-05-20T20:56:46.262917Z","end":"2026-05-20T20:56:46.569972Z","steps":["trace[1838634995] 'process raft request' (duration: 306.788905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:46.570064Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:46.262886Z","time spent":"307.126257ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:46.570966Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"158.391046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T20:56:46.571014Z","caller":"traceutil/trace.go:172","msg":"trace[299795832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:641; }","duration":"158.456146ms","start":"2026-05-20T20:56:46.412542Z","end":"2026-05-20T20:56:46.570998Z","steps":["trace[299795832] 'agreement among raft nodes before linearized reading' (duration: 156.935734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:46.819848Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"238.768493ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:56:46.820054Z","caller":"traceutil/trace.go:172","msg":"trace[836322138] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"244.823909ms","start":"2026-05-20T20:56:46.575214Z","end":"2026-05-20T20:56:46.820038Z","steps":["trace[836322138] 'compare' (duration: 238.660552ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:46.820134Z","caller":"traceutil/trace.go:172","msg":"trace[1171471689] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"244.615167ms","start":"2026-05-20T20:56:46.575475Z","end":"2026-05-20T20:56:46.820091Z","steps":["trace[1171471689] 'process raft request' (duration: 244.465036ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:46.820186Z","caller":"traceutil/trace.go:172","msg":"trace[1238560492] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"212.286693ms","start":"2026-05-20T20:56:46.607745Z","end":"2026-05-20T20:56:46.820032Z","steps":["trace[1238560492] 'process raft request' (duration: 212.248642ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:47.581968Z","caller":"traceutil/trace.go:172","msg":"trace[637218253] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"352.460445ms","start":"2026-05-20T20:56:47.229381Z","end":"2026-05-20T20:56:47.581841Z","steps":["trace[637218253] 'process raft request' (duration: 350.023406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:47.582468Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:47.229349Z","time spent":"352.744857ms","remote":"127.0.0.1:34098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036157,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:47.912529Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"212.988698ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-20T20:56:47.912881Z","caller":"traceutil/trace.go:172","msg":"trace[1334954483] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"209.129269ms","start":"2026-05-20T20:56:47.703739Z","end":"2026-05-20T20:56:47.912868Z","steps":["trace[1334954483] 'process raft request' (duration: 208.988348ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:50.921056Z","caller":"traceutil/trace.go:172","msg":"trace[447457836] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"311.289868ms","start":"2026-05-20T20:56:50.609711Z","end":"2026-05-20T20:56:50.921001Z","steps":["trace[447457836] 'process raft request' (duration: 311.018256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:50.921544Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:50.609679Z","time spent":"311.519281ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:51.218948Z","caller":"traceutil/trace.go:172","msg":"trace[2114297318] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:696; }","duration":"298.301966ms","start":"2026-05-20T20:56:50.920606Z","end":"2026-05-20T20:56:51.218908Z","steps":["trace[2114297318] 'read index received' (duration: 298.292686ms)","trace[2114297318] 'applied index is now lower than readState.Index' (duration: 7.28µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:51.833629Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"954.890349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T20:56:51.833702Z","caller":"traceutil/trace.go:172","msg":"trace[1529817374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:671; }","duration":"954.970479ms","start":"2026-05-20T20:56:50.878715Z","end":"2026-05-20T20:56:51.833685Z","steps":["trace[1529817374] 'agreement among raft nodes before linearized reading' (duration: 340.293064ms)","trace[1529817374] 'range keys from in-memory index tree' (duration: 614.499424ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:51.833739Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:50.878696Z","time spent":"955.033509ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:51.833934Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"614.875197ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:56:51.834094Z","caller":"traceutil/trace.go:172","msg":"trace[1038596581] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"905.358974ms","start":"2026-05-20T20:56:50.928723Z","end":"2026-05-20T20:56:51.834082Z","steps":["trace[1038596581] 'process raft request' (duration: 905.297523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:51.834169Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:50.928689Z","time spent":"905.444975ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:51.834288Z","caller":"traceutil/trace.go:172","msg":"trace[65442754] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"615.247759ms","start":"2026-05-20T20:56:51.219026Z","end":"2026-05-20T20:56:51.834274Z","steps":["trace[65442754] 'read index received' (duration: 196.600143ms)","trace[65442754] 'applied index is now lower than readState.Index' (duration: 418.645536ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:56:51.834289Z","caller":"traceutil/trace.go:172","msg":"trace[2101041415] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"1.215530783s","start":"2026-05-20T20:56:50.618719Z","end":"2026-05-20T20:56:51.834249Z","steps":["trace[2101041415] 'process raft request' (duration: 600.279613ms)","trace[2101041415] 'compare' (duration: 614.409253ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:51.834436Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:50.618685Z","time spent":"1.215676145s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:51.834457Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"719.430784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gvrkr\" limit:1 ","response":"range_response_count:1 size:18345"} {"level":"info","ts":"2026-05-20T20:56:51.834486Z","caller":"traceutil/trace.go:172","msg":"trace[538464827] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gvrkr; range_end:; response_count:1; response_revision:673; }","duration":"719.462505ms","start":"2026-05-20T20:56:51.115015Z","end":"2026-05-20T20:56:51.834477Z","steps":["trace[538464827] 'agreement among raft nodes before linearized reading' (duration: 719.352774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:51.834510Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:51.114993Z","time spent":"719.510256ms","remote":"127.0.0.1:34306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18367,"request content":"key:\"/registry/pods/kube-system/cilium-gvrkr\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:51.834510Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"308.757078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:56:51.834550Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"829.929627ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:51.834566Z","caller":"traceutil/trace.go:172","msg":"trace[2119550222] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:673; }","duration":"308.811758ms","start":"2026-05-20T20:56:51.525741Z","end":"2026-05-20T20:56:51.834553Z","steps":["trace[2119550222] 'agreement among raft nodes before linearized reading' (duration: 308.731298ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:51.834581Z","caller":"traceutil/trace.go:172","msg":"trace[1616760371] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:673; }","duration":"829.966497ms","start":"2026-05-20T20:56:51.004607Z","end":"2026-05-20T20:56:51.834574Z","steps":["trace[1616760371] 'agreement among raft nodes before linearized reading' (duration: 829.907927ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:51.834602Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:51.525705Z","time spent":"308.891249ms","remote":"127.0.0.1:33960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T20:56:52.704582Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683029426,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:56:53.205674Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683029426,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:56:53.373504Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.34108058s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:56:53.373620Z","caller":"traceutil/trace.go:172","msg":"trace[983055183] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"1.535891029s","start":"2026-05-20T20:56:51.837709Z","end":"2026-05-20T20:56:53.373600Z","steps":["trace[983055183] 'process raft request' (duration: 194.614658ms)","trace[983055183] 'compare' (duration: 1.340934749s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:53.373687Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:51.837687Z","time spent":"1.53596746s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:53.373661Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.368800022s","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-05-20T20:56:53.373776Z","caller":"traceutil/trace.go:172","msg":"trace[40446150] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:673; }","duration":"1.369486697s","start":"2026-05-20T20:56:52.004238Z","end":"2026-05-20T20:56:53.373724Z","steps":["trace[40446150] 'range keys from in-memory index tree' (duration: 1.368753182s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:53.534753Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.502745025s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T20:56:53.535042Z","caller":"traceutil/trace.go:172","msg":"trace[224237784] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:699; }","duration":"1.330741347s","start":"2026-05-20T20:56:52.204264Z","end":"2026-05-20T20:56:53.535005Z","steps":["trace[224237784] 'read index received' (duration: 1.330726857s)","trace[224237784] 'applied index is now lower than readState.Index' (duration: 12.36µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:53.674453Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.470136411s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-20T20:56:53.674533Z","caller":"traceutil/trace.go:172","msg":"trace[984605798] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:674; }","duration":"1.470253892s","start":"2026-05-20T20:56:52.204259Z","end":"2026-05-20T20:56:53.674513Z","steps":["trace[984605798] 'agreement among raft nodes before linearized reading' (duration: 1.330900858s)","trace[984605798] 'range keys from in-memory index tree' (duration: 139.093842ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:53.674595Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:52.204238Z","time spent":"1.470328553s","remote":"127.0.0.1:34000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.38\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:53.674701Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"139.350054ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:56:53.674985Z","caller":"traceutil/trace.go:172","msg":"trace[1381521814] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"739.059438ms","start":"2026-05-20T20:56:52.935905Z","end":"2026-05-20T20:56:53.674964Z","steps":["trace[1381521814] 'process raft request' (duration: 739.002368ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:53.675044Z","caller":"traceutil/trace.go:172","msg":"trace[1273514197] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"139.895908ms","start":"2026-05-20T20:56:53.535126Z","end":"2026-05-20T20:56:53.675022Z","steps":["trace[1273514197] 'read index received' (duration: 106.339614ms)","trace[1273514197] 'applied index is now lower than readState.Index' (duration: 33.551714ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:53.675123Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:52.935875Z","time spent":"739.172649ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:53.675259Z","caller":"traceutil/trace.go:172","msg":"trace[690992432] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"1.113648906s","start":"2026-05-20T20:56:52.561577Z","end":"2026-05-20T20:56:53.675226Z","steps":["trace[690992432] 'process raft request' (duration: 1.113251523s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:53.675132Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"300.661787ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:53.675361Z","caller":"traceutil/trace.go:172","msg":"trace[355259952] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"1.827071816s","start":"2026-05-20T20:56:51.848267Z","end":"2026-05-20T20:56:53.675338Z","steps":["trace[355259952] 'process raft request' (duration: 1.686963847s)","trace[355259952] 'compare' (duration: 139.227453ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:53.675385Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:52.561549Z","time spent":"1.113762207s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:56:53.675396Z","caller":"traceutil/trace.go:172","msg":"trace[1061361004] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:677; }","duration":"300.925609ms","start":"2026-05-20T20:56:53.374454Z","end":"2026-05-20T20:56:53.675379Z","steps":["trace[1061361004] 'agreement among raft nodes before linearized reading' (duration: 300.632807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:53.675448Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:51.848239Z","time spent":"1.827161456s","remote":"127.0.0.1:34306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18502,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:53.675833Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"149.91451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:53.675882Z","caller":"traceutil/trace.go:172","msg":"trace[517268226] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"149.966081ms","start":"2026-05-20T20:56:53.525903Z","end":"2026-05-20T20:56:53.675869Z","steps":["trace[517268226] 'agreement among raft nodes before linearized reading' (duration: 149.88799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:55.879775Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683029441,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:56:56.380973Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683029441,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:56:56.798828Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.794718096s","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-05-20T20:56:56.798928Z","caller":"traceutil/trace.go:172","msg":"trace[1707627513] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:678; }","duration":"2.794832997s","start":"2026-05-20T20:56:54.004079Z","end":"2026-05-20T20:56:56.798912Z","steps":["trace[1707627513] 'range keys from in-memory index tree' (duration: 2.794667826s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:56.799076Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.959861118s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T20:56:56.799172Z","caller":"traceutil/trace.go:172","msg":"trace[1737759578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:678; }","duration":"2.959973188s","start":"2026-05-20T20:56:53.839179Z","end":"2026-05-20T20:56:56.799152Z","steps":["trace[1737759578] 'range keys from in-memory index tree' (duration: 2.959266543s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:56.799226Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:53.839157Z","time spent":"2.960054399s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:56:56.881664Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757020542683029441,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:56:56.899172Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"3.057077645s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T20:56:56.899443Z","caller":"traceutil/trace.go:172","msg":"trace[528951937] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:704; }","duration":"1.520367737s","start":"2026-05-20T20:56:55.379052Z","end":"2026-05-20T20:56:56.899419Z","steps":["trace[528951937] 'read index received' (duration: 1.520361067s)","trace[528951937] 'applied index is now lower than readState.Index' (duration: 5.38µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:56:56.899649Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.520575058s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T20:56:56.899688Z","caller":"traceutil/trace.go:172","msg":"trace[122902490] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:678; }","duration":"1.520631399s","start":"2026-05-20T20:56:55.379047Z","end":"2026-05-20T20:56:56.899678Z","steps":["trace[122902490] 'agreement among raft nodes before linearized reading' (duration: 1.520454407s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:56.899721Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:55.379026Z","time spent":"1.520687479s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-05-20T20:56:56.900259Z","caller":"traceutil/trace.go:172","msg":"trace[490122010] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"3.058271753s","start":"2026-05-20T20:56:53.841974Z","end":"2026-05-20T20:56:56.900246Z","steps":["trace[490122010] 'process raft request' (duration: 3.058175442s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:56.900355Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:53.841947Z","time spent":"3.058353534s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:56.911205Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"112.214515ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:56:56.911208Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.385828787s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:56.911287Z","caller":"traceutil/trace.go:172","msg":"trace[1044232116] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:679; }","duration":"112.306546ms","start":"2026-05-20T20:56:56.798964Z","end":"2026-05-20T20:56:56.911270Z","steps":["trace[1044232116] 'agreement among raft nodes before linearized reading' (duration: 112.173445ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:56.911529Z","caller":"traceutil/trace.go:172","msg":"trace[147266623] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"1.229951974s","start":"2026-05-20T20:56:55.681564Z","end":"2026-05-20T20:56:56.911516Z","steps":["trace[147266623] 'process raft request' (duration: 1.229722922s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:56.911545Z","caller":"traceutil/trace.go:172","msg":"trace[1213279614] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"108.121726ms","start":"2026-05-20T20:56:56.803401Z","end":"2026-05-20T20:56:56.911523Z","steps":["trace[1213279614] 'process raft request' (duration: 108.077465ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:56:56.911398Z","caller":"traceutil/trace.go:172","msg":"trace[79636779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:679; }","duration":"1.385955118s","start":"2026-05-20T20:56:55.525329Z","end":"2026-05-20T20:56:56.911284Z","steps":["trace[79636779] 'agreement among raft nodes before linearized reading' (duration: 1.385778237s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:56.911678Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:55.525308Z","time spent":"1.386359762s","remote":"127.0.0.1:33960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T20:56:56.911807Z","caller":"traceutil/trace.go:172","msg":"trace[1756007876] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"1.200207509s","start":"2026-05-20T20:56:55.711582Z","end":"2026-05-20T20:56:56.911789Z","steps":["trace[1756007876] 'process raft request' (duration: 1.199855517s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:56:56.911972Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:55.711560Z","time spent":"1.20028917s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:56.912056Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:56:55.681526Z","time spent":"1.230037645s","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:56:59.861961Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"161.706025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:56:59.862127Z","caller":"traceutil/trace.go:172","msg":"trace[796397325] range","detail":"{range_begin:/registry/runtimeclasses; range_end:; response_count:0; response_revision:702; }","duration":"161.877286ms","start":"2026-05-20T20:56:59.700233Z","end":"2026-05-20T20:56:59.862110Z","steps":["trace[796397325] 'range keys from in-memory index tree' (duration: 161.630365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:57:08.431846Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39648","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.467013Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39666","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.493225Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39696","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.524535Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39708","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.550600Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39746","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.580267Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39774","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.598115Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39790","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.618178Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39808","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.637417Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39820","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.680237Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39854","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.706038Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39870","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.727256Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39898","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.748695Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39902","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.793859Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39942","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.868347Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39954","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.954700Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39958","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.974124Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39976","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:08.987559Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40000","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.009317Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40024","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.048163Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40046","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.070460Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40050","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.089096Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40088","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.105117Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40094","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.118922Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40112","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.138238Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56408","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.152532Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56410","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.164807Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56428","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.179459Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56442","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.196531Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56468","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.212654Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56480","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.228260Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56500","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.241590Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56528","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.256235Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56558","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.267234Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56588","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:57:09.288536Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56604","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-20T20:57:19.536626Z","caller":"traceutil/trace.go:172","msg":"trace[508968214] linearizableReadLoop","detail":"{readStateIndex:907; appliedIndex:907; }","duration":"238.770463ms","start":"2026-05-20T20:57:19.297834Z","end":"2026-05-20T20:57:19.536605Z","steps":["trace[508968214] 'read index received' (duration: 238.764773ms)","trace[508968214] 'applied index is now lower than readState.Index' (duration: 4.53µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:57:19.536786Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"238.935109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:57:19.536812Z","caller":"traceutil/trace.go:172","msg":"trace[1444656298] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:873; }","duration":"238.986202ms","start":"2026-05-20T20:57:19.297819Z","end":"2026-05-20T20:57:19.536805Z","steps":["trace[1444656298] 'agreement among raft nodes before linearized reading' (duration: 238.899208ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:57:19.537620Z","caller":"traceutil/trace.go:172","msg":"trace[1984395433] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"266.514456ms","start":"2026-05-20T20:57:19.271081Z","end":"2026-05-20T20:57:19.537596Z","steps":["trace[1984395433] 'process raft request' (duration: 265.946595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:57:20.451633Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"446.664799ms","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-05-20T20:57:20.451740Z","caller":"traceutil/trace.go:172","msg":"trace[2006555688] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:874; }","duration":"447.323944ms","start":"2026-05-20T20:57:20.004397Z","end":"2026-05-20T20:57:20.451721Z","steps":["trace[2006555688] 'range keys from in-memory index tree' (duration: 446.612157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:57:20.452397Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"430.232665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-20T20:57:20.452651Z","caller":"traceutil/trace.go:172","msg":"trace[172931083] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:874; }","duration":"430.492754ms","start":"2026-05-20T20:57:20.022145Z","end":"2026-05-20T20:57:20.452638Z","steps":["trace[172931083] 'range keys from in-memory index tree' (duration: 429.5523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:57:20.452945Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"190.836213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:57:20.453043Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:57:20.022122Z","time spent":"430.909031ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"info","ts":"2026-05-20T20:57:20.452987Z","caller":"traceutil/trace.go:172","msg":"trace[1806641292] range","detail":"{range_begin:/registry/services/specs; range_end:; response_count:0; response_revision:874; }","duration":"190.99575ms","start":"2026-05-20T20:57:20.261980Z","end":"2026-05-20T20:57:20.452976Z","steps":["trace[1806641292] 'range keys from in-memory index tree' (duration: 190.76079ms)"],"step_count":1}