{"level":"warn","ts":"2026-03-17T20:45:33.382064Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-03-17T20:45:33.382193Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-03-17T20:45:33.382208Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.143:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.19.213.143:2380","--initial-cluster=controller=https://199.19.213.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.143:2380","--name=controller","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-03-17T20:45:33.382285Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-03-17T20:45:33.382304Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-17T20:45:33.382314Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.143:2380"]} {"level":"info","ts":"2026-03-17T20:45:33.382360Z","caller":"embed/etcd.go:544","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-17T20:45:33.383268Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"]} {"level":"info","ts":"2026-03-17T20:45:33.383357Z","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.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.19.213.143: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-03-17T20:45:33.384047Z","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: 0xc0003ba0e0}"} {"level":"info","ts":"2026-03-17T20:45:33.446019Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-03-17T20:45:33.446127Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"62.174311ms"} {"level":"info","ts":"2026-03-17T20:45:33.446165Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-03-17T20:45:33.446178Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-03-17T20:45:33.446253Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-03-17T20:45:33.466105Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-03-17T20:45:33.466210Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"e5bed6df0e44a0b1","cluster-id":"4e2f0a715964d622"} {"level":"info","ts":"2026-03-17T20:45:33.466239Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-03-17T20:45:33.466309Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"e5bed6df0e44a0b1 switched to configuration voters=()"} {"level":"info","ts":"2026-03-17T20:45:33.466359Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"e5bed6df0e44a0b1 became follower at term 0"} {"level":"info","ts":"2026-03-17T20:45:33.466370Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft e5bed6df0e44a0b1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-17T20:45:33.466384Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"e5bed6df0e44a0b1 became follower at term 1"} {"level":"info","ts":"2026-03-17T20:45:33.466426Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"} {"level":"warn","ts":"2026-03-17T20:45:33.485541Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-17T20:45:33.489800Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-17T20:45:33.492607Z","caller":"storage/quota.go:93","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-03-17T20:45:33.493307Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"e5bed6df0e44a0b1","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-17T20:45:33.493546Z","caller":"embed/etcd.go:766","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-17T20:45:33.493909Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e5bed6df0e44a0b1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-17T20:45:33.493956Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"e5bed6df0e44a0b1","initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-17T20:45:33.493994Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-17T20:45:33.493896Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-17T20:45:33.494273Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-17T20:45:33.494293Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-17T20:45:33.494252Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-03-17T20:45:33.494342Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-03-17T20:45:33.494898Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"} {"level":"info","ts":"2026-03-17T20:45:33.495053Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","added-peer-id":"e5bed6df0e44a0b1","added-peer-peer-urls":["https://199.19.213.143:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-03-17T20:45:33.966728Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"e5bed6df0e44a0b1 is starting a new election at term 1"} {"level":"info","ts":"2026-03-17T20:45:33.966797Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"e5bed6df0e44a0b1 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-17T20:45:33.966858Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"e5bed6df0e44a0b1 received MsgPreVoteResp from e5bed6df0e44a0b1 at term 1"} {"level":"info","ts":"2026-03-17T20:45:33.966976Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"e5bed6df0e44a0b1 has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-03-17T20:45:33.966999Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"e5bed6df0e44a0b1 became candidate at term 2"} {"level":"info","ts":"2026-03-17T20:45:34.057009Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"e5bed6df0e44a0b1 received MsgVoteResp from e5bed6df0e44a0b1 at term 2"} {"level":"info","ts":"2026-03-17T20:45:34.057073Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"e5bed6df0e44a0b1 has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-03-17T20:45:34.057096Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"e5bed6df0e44a0b1 became leader at term 2"} {"level":"info","ts":"2026-03-17T20:45:34.057104Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: e5bed6df0e44a0b1 elected leader e5bed6df0e44a0b1 at term 2"} {"level":"info","ts":"2026-03-17T20:45:34.093486Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"e5bed6df0e44a0b1","local-member-attributes":"{Name:controller ClientURLs:[https://199.19.213.143:2379]}","cluster-id":"4e2f0a715964d622","publish-timeout":"7s"} {"level":"info","ts":"2026-03-17T20:45:34.093524Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-17T20:45:34.093533Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-17T20:45:34.093545Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-03-17T20:45:34.093989Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-17T20:45:34.094023Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-17T20:45:34.096516Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-03-17T20:45:34.099022Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-03-17T20:45:34.099183Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-03-17T20:45:34.104369Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-17T20:45:34.105418Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.143:2379"} {"level":"info","ts":"2026-03-17T20:45:34.139859Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","cluster-version":"3.6"} {"level":"info","ts":"2026-03-17T20:45:34.190311Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-03-17T20:45:34.190407Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-03-17T20:45:34.190533Z","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-03-17T20:45:34.190592Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"warn","ts":"2026-03-17T20:45:34.703425Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47710","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.703459Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47730","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.731740Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47780","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.772273Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47802","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.780521Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47814","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.790167Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47846","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.801621Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47852","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.808187Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47866","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.814968Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47884","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.822899Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47902","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.830091Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47924","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.843644Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47936","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.854584Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47956","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.878093Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48002","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.886930Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48010","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.897174Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48018","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.905407Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48036","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.915695Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48038","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.927512Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48060","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.975842Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48090","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.988164Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48102","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:34.997567Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48122","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.006747Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48152","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.029960Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48168","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.035010Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48204","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.042509Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48220","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.051776Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48264","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.063927Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48282","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.074513Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48290","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.083865Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48322","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.097583Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48338","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.105380Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48366","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.115725Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48382","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.125420Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48404","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.133963Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48416","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.144600Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48430","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.152882Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48454","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.165911Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48492","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.173332Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48508","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.184628Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48512","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.192583Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48520","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.211365Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48532","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.217889Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48552","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.257548Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48574","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.277768Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48614","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.288101Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48640","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.296128Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48668","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.304256Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48674","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.321162Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48698","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.328932Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48706","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.336732Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48716","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.344576Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48730","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.353959Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48742","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.362657Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48750","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.404258Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48764","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.413399Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48778","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.423474Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48806","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:35.472615Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48822","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:45:36.513767Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208729734912656,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-17T20:45:36.553258Z","caller":"traceutil/trace.go:172","msg":"trace[1499500429] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:6; }","duration":"540.060927ms","start":"2026-03-17T20:45:36.013146Z","end":"2026-03-17T20:45:36.553207Z","steps":["trace[1499500429] 'read index received' (duration: 540.043596ms)","trace[1499500429] 'applied index is now lower than readState.Index' (duration: 14.751µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:36.553572Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"540.391116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-17T20:45:36.553617Z","caller":"traceutil/trace.go:172","msg":"trace[305161406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4; }","duration":"540.476658ms","start":"2026-03-17T20:45:36.013130Z","end":"2026-03-17T20:45:36.553606Z","steps":["trace[305161406] 'agreement among raft nodes before linearized reading' (duration: 540.310073ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:36.553619Z","caller":"traceutil/trace.go:172","msg":"trace[1045954153] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"565.794583ms","start":"2026-03-17T20:45:35.987783Z","end":"2026-03-17T20:45:36.553577Z","steps":["trace[1045954153] 'process raft request' (duration: 565.521495ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:36.553911Z","caller":"traceutil/trace.go:172","msg":"trace[526857228] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"565.968587ms","start":"2026-03-17T20:45:35.987902Z","end":"2026-03-17T20:45:36.553871Z","steps":["trace[526857228] 'process raft request' (duration: 565.562246ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:36.554079Z","caller":"traceutil/trace.go:172","msg":"trace[734026484] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"566.107682ms","start":"2026-03-17T20:45:35.987959Z","end":"2026-03-17T20:45:36.554067Z","steps":["trace[734026484] 'process raft request' (duration: 565.553426ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:36.554184Z","caller":"traceutil/trace.go:172","msg":"trace[45997416] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"565.344499ms","start":"2026-03-17T20:45:35.988783Z","end":"2026-03-17T20:45:36.554128Z","steps":["trace[45997416] 'process raft request' (duration: 564.848175ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:36.554222Z","caller":"traceutil/trace.go:172","msg":"trace[1065613293] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"565.858835ms","start":"2026-03-17T20:45:35.988355Z","end":"2026-03-17T20:45:36.554214Z","steps":["trace[1065613293] 'process raft request' (duration: 565.204957ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:36.554236Z","caller":"traceutil/trace.go:172","msg":"trace[768189989] transaction","detail":"{read_only:false; number_of_response:0; response_revision:10; }","duration":"562.9544ms","start":"2026-03-17T20:45:35.991258Z","end":"2026-03-17T20:45:36.554213Z","steps":["trace[768189989] 'process raft request' (duration: 562.488217ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:36.554309Z","caller":"traceutil/trace.go:172","msg":"trace[2019444648] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"564.753293ms","start":"2026-03-17T20:45:35.989545Z","end":"2026-03-17T20:45:36.554299Z","steps":["trace[2019444648] 'process raft request' (duration: 564.127765ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:36.553661Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.013110Z","time spent":"540.54329ms","remote":"127.0.0.1:47722","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-03-17T20:45:36.555129Z","caller":"traceutil/trace.go:172","msg":"trace[1731428103] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"565.74187ms","start":"2026-03-17T20:45:35.988484Z","end":"2026-03-17T20:45:36.554225Z","steps":["trace[1731428103] 'process raft request' (duration: 565.117883ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:36.555859Z","caller":"traceutil/trace.go:172","msg":"trace[826860800] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"557.272339ms","start":"2026-03-17T20:45:35.996744Z","end":"2026-03-17T20:45:36.554017Z","steps":["trace[826860800] 'process raft request' (duration: 557.167686ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:36.556184Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:35.987766Z","time spent":"566.036919ms","remote":"127.0.0.1:47886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:36.556242Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:35.996730Z","time spent":"559.357298ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2886,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:36.556546Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:35.988470Z","time spent":"566.727019ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:36.556648Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:35.987883Z","time spent":"566.116342ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:36.556765Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:35.987946Z","time spent":"566.159313ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:36.556941Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:35.988760Z","time spent":"565.443772ms","remote":"127.0.0.1:48306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":280,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:36.557154Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:35.988343Z","time spent":"565.901296ms","remote":"127.0.0.1:48586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":688,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:36.557322Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:35.991244Z","time spent":"563.036854ms","remote":"127.0.0.1:47886","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:36.557475Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:35.989526Z","time spent":"564.823355ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:36.632639Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"466.564576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-ho7paesrdksqaoi6iuwwu33dmq\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-17T20:45:36.632731Z","caller":"traceutil/trace.go:172","msg":"trace[823348987] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-ho7paesrdksqaoi6iuwwu33dmq; range_end:; response_count:0; response_revision:11; }","duration":"466.66778ms","start":"2026-03-17T20:45:36.166043Z","end":"2026-03-17T20:45:36.632711Z","steps":["trace[823348987] 'agreement among raft nodes before linearized reading' (duration: 466.509445ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:36.632775Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.166018Z","time spent":"466.747043ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-ho7paesrdksqaoi6iuwwu33dmq\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:36.633054Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"595.929691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-03-17T20:45:36.633093Z","caller":"traceutil/trace.go:172","msg":"trace[279799164] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:12; }","duration":"595.967153ms","start":"2026-03-17T20:45:36.037115Z","end":"2026-03-17T20:45:36.633082Z","steps":["trace[279799164] 'agreement among raft nodes before linearized reading' (duration: 595.89105ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:36.633063Z","caller":"traceutil/trace.go:172","msg":"trace[60256417] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"616.973853ms","start":"2026-03-17T20:45:36.016066Z","end":"2026-03-17T20:45:36.633039Z","steps":["trace[60256417] 'process raft request' (duration: 616.8693ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:36.633154Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"613.137853ms","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-03-17T20:45:36.633191Z","caller":"traceutil/trace.go:172","msg":"trace[1668925449] range","detail":"{range_begin:/registry/csinodes/controller; range_end:; response_count:0; response_revision:12; }","duration":"613.173354ms","start":"2026-03-17T20:45:36.020010Z","end":"2026-03-17T20:45:36.633183Z","steps":["trace[1668925449] 'agreement among raft nodes before linearized reading' (duration: 613.122443ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:36.633215Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.019994Z","time spent":"613.215295ms","remote":"127.0.0.1:48514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":33,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/controller\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:36.633243Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.016051Z","time spent":"617.098026ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:36.633119Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.037095Z","time spent":"596.017664ms","remote":"127.0.0.1:47886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"info","ts":"2026-03-17T20:45:36.860851Z","caller":"traceutil/trace.go:172","msg":"trace[2072641126] linearizableReadLoop","detail":"{readStateIndex:16; appliedIndex:16; }","duration":"228.302161ms","start":"2026-03-17T20:45:36.632522Z","end":"2026-03-17T20:45:36.860824Z","steps":["trace[2072641126] 'read index received' (duration: 228.293821ms)","trace[2072641126] 'applied index is now lower than readState.Index' (duration: 7.23µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:37.188679Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"624.711638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/controller\" limit:1 ","response":"range_response_count:1 size:2898"} {"level":"info","ts":"2026-03-17T20:45:37.188775Z","caller":"traceutil/trace.go:172","msg":"trace[661713408] range","detail":"{range_begin:/registry/minions/controller; range_end:; response_count:1; response_revision:12; }","duration":"624.827641ms","start":"2026-03-17T20:45:36.563927Z","end":"2026-03-17T20:45:37.188755Z","steps":["trace[661713408] 'agreement among raft nodes before linearized reading' (duration: 296.937731ms)","trace[661713408] 'range keys from in-memory index tree' (duration: 327.697045ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:37.188753Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"627.860477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-03-17T20:45:37.188822Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.563897Z","time spent":"624.915264ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":32,"response count":1,"response size":2921,"request content":"key:\"/registry/minions/controller\" limit:1 "} {"level":"info","ts":"2026-03-17T20:45:37.188836Z","caller":"traceutil/trace.go:172","msg":"trace[1706280619] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:12; }","duration":"627.959851ms","start":"2026-03-17T20:45:36.560859Z","end":"2026-03-17T20:45:37.188819Z","steps":["trace[1706280619] 'agreement among raft nodes before linearized reading' (duration: 300.077471ms)","trace[1706280619] 'range keys from in-memory index tree' (duration: 327.734026ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:37.188870Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.560830Z","time spent":"628.032782ms","remote":"127.0.0.1:47886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:37.189259Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"327.88443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-03-17T20:45:37.190049Z","caller":"traceutil/trace.go:172","msg":"trace[1920892734] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"621.639529ms","start":"2026-03-17T20:45:36.568397Z","end":"2026-03-17T20:45:37.190036Z","steps":["trace[1920892734] 'process raft request' (duration: 621.559707ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:37.190408Z","caller":"traceutil/trace.go:172","msg":"trace[1075026547] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"628.331832ms","start":"2026-03-17T20:45:36.562057Z","end":"2026-03-17T20:45:37.190389Z","steps":["trace[1075026547] 'process raft request' (duration: 627.562469ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:37.190437Z","caller":"traceutil/trace.go:172","msg":"trace[173781234] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"628.691832ms","start":"2026-03-17T20:45:36.561724Z","end":"2026-03-17T20:45:37.190416Z","steps":["trace[173781234] 'process raft request' (duration: 627.636211ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.190549Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.561346Z","time spent":"629.146835ms","remote":"127.0.0.1:48586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":694,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.190674Z","caller":"traceutil/trace.go:172","msg":"trace[433466241] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"623.911365ms","start":"2026-03-17T20:45:36.566754Z","end":"2026-03-17T20:45:37.190666Z","steps":["trace[433466241] 'process raft request' (duration: 622.972077ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.190713Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.566712Z","time spent":"623.985807ms","remote":"127.0.0.1:47886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:37.190739Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.568388Z","time spent":"621.729891ms","remote":"127.0.0.1:48306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":586,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:45:37.190985Z","caller":"traceutil/trace.go:172","msg":"trace[1741043156] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"624.085809ms","start":"2026-03-17T20:45:36.566891Z","end":"2026-03-17T20:45:37.190976Z","steps":["trace[1741043156] 'process raft request' (duration: 622.960937ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.191033Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.566882Z","time spent":"624.133511ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:37.190499Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.562033Z","time spent":"628.425354ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.190823Z","caller":"traceutil/trace.go:172","msg":"trace[1314071918] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"628.678342ms","start":"2026-03-17T20:45:36.562137Z","end":"2026-03-17T20:45:37.190815Z","steps":["trace[1314071918] 'process raft request' (duration: 627.56381ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.191777Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.562131Z","time spent":"629.512265ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.192400Z","caller":"traceutil/trace.go:172","msg":"trace[1011357805] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"629.943037ms","start":"2026-03-17T20:45:36.561114Z","end":"2026-03-17T20:45:37.191057Z","steps":["trace[1011357805] 'process raft request' (duration: 299.904045ms)","trace[1011357805] 'compare' (duration: 327.558191ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:37.192831Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.561098Z","time spent":"631.585153ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.321673Z","caller":"traceutil/trace.go:172","msg":"trace[1894075968] linearizableReadLoop","detail":"{readStateIndex:23; appliedIndex:23; }","duration":"460.680894ms","start":"2026-03-17T20:45:36.860930Z","end":"2026-03-17T20:45:37.321611Z","steps":["trace[1894075968] 'read index received' (duration: 460.669643ms)","trace[1894075968] 'applied index is now lower than readState.Index' (duration: 9.301µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:37.454523Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"817.507528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/controller\" limit:1 ","response":"range_response_count:1 size:2898"} {"level":"warn","ts":"2026-03-17T20:45:37.454549Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"132.700722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-03-17T20:45:37.454594Z","caller":"traceutil/trace.go:172","msg":"trace[1910470967] range","detail":"{range_begin:/registry/minions/controller; range_end:; response_count:1; response_revision:19; }","duration":"817.58386ms","start":"2026-03-17T20:45:36.636993Z","end":"2026-03-17T20:45:37.454577Z","steps":["trace[1910470967] 'agreement among raft nodes before linearized reading' (duration: 684.725843ms)","trace[1910470967] 'range keys from in-memory index tree' (duration: 132.653931ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:37.454631Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.636976Z","time spent":"817.646592ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":32,"response count":1,"response size":2921,"request content":"key:\"/registry/minions/controller\" limit:1 "} {"level":"info","ts":"2026-03-17T20:45:37.454714Z","caller":"traceutil/trace.go:172","msg":"trace[596978796] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"816.668244ms","start":"2026-03-17T20:45:36.638035Z","end":"2026-03-17T20:45:37.454703Z","steps":["trace[596978796] 'process raft request' (duration: 816.636013ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.454773Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.637994Z","time spent":"816.757937ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.454750Z","caller":"traceutil/trace.go:172","msg":"trace[1374618211] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"816.747947ms","start":"2026-03-17T20:45:36.637964Z","end":"2026-03-17T20:45:37.454712Z","steps":["trace[1374618211] 'process raft request' (duration: 683.826048ms)","trace[1374618211] 'compare' (duration: 132.580929ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:37.454793Z","caller":"traceutil/trace.go:172","msg":"trace[329193061] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"816.727026ms","start":"2026-03-17T20:45:36.638031Z","end":"2026-03-17T20:45:37.454758Z","steps":["trace[329193061] 'process raft request' (duration: 816.592802ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.454891Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.637937Z","time spent":"816.88841ms","remote":"127.0.0.1:47874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:37.454964Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.638001Z","time spent":"816.86326ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.598665Z","caller":"traceutil/trace.go:172","msg":"trace[616915884] linearizableReadLoop","detail":"{readStateIndex:26; appliedIndex:26; }","duration":"276.768056ms","start":"2026-03-17T20:45:37.321864Z","end":"2026-03-17T20:45:37.598632Z","steps":["trace[616915884] 'read index received' (duration: 276.758866ms)","trace[616915884] 'applied index is now lower than readState.Index' (duration: 8.23µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:37.826047Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"942.137076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-17T20:45:37.826114Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"738.581144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-17T20:45:37.826139Z","caller":"traceutil/trace.go:172","msg":"trace[2129753026] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:22; }","duration":"942.24077ms","start":"2026-03-17T20:45:36.883876Z","end":"2026-03-17T20:45:37.826117Z","steps":["trace[2129753026] 'agreement among raft nodes before linearized reading' (duration: 714.860736ms)","trace[2129753026] 'range keys from in-memory index tree' (duration: 227.245089ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:37.826162Z","caller":"traceutil/trace.go:172","msg":"trace[2028520516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22; }","duration":"738.618245ms","start":"2026-03-17T20:45:37.087524Z","end":"2026-03-17T20:45:37.826142Z","steps":["trace[2028520516] 'agreement among raft nodes before linearized reading' (duration: 511.127018ms)","trace[2028520516] 'range keys from in-memory index tree' (duration: 227.427526ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:37.826151Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"941.804698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-17T20:45:37.826201Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.087490Z","time spent":"738.700917ms","remote":"127.0.0.1:47740","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-03-17T20:45:37.826192Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"631.046608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-17T20:45:37.826268Z","caller":"traceutil/trace.go:172","msg":"trace[443598892] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:22; }","duration":"631.1107ms","start":"2026-03-17T20:45:37.195128Z","end":"2026-03-17T20:45:37.826239Z","steps":["trace[443598892] 'agreement among raft nodes before linearized reading' (duration: 403.553081ms)","trace[443598892] 'range keys from in-memory index tree' (duration: 227.463857ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:37.826252Z","caller":"traceutil/trace.go:172","msg":"trace[97231034] range","detail":"{range_begin:/registry/clusterroles; range_end:; response_count:0; response_revision:22; }","duration":"941.917831ms","start":"2026-03-17T20:45:36.884307Z","end":"2026-03-17T20:45:37.826225Z","steps":["trace[97231034] 'agreement among raft nodes before linearized reading' (duration: 714.400313ms)","trace[97231034] 'range keys from in-memory index tree' (duration: 227.371453ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:37.826193Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.883834Z","time spent":"942.344263ms","remote":"127.0.0.1:48438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:37.826326Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:36.884296Z","time spent":"942.015074ms","remote":"127.0.0.1:48414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:37.826327Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.195111Z","time spent":"631.200743ms","remote":"127.0.0.1:47874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:37.826395Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"227.58694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"warn","ts":"2026-03-17T20:45:37.826048Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"814.890883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-17T20:45:37.827864Z","caller":"traceutil/trace.go:172","msg":"trace[1799999853] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:22; }","duration":"816.684604ms","start":"2026-03-17T20:45:37.011126Z","end":"2026-03-17T20:45:37.827811Z","steps":["trace[1799999853] 'agreement among raft nodes before linearized reading' (duration: 587.570991ms)","trace[1799999853] 'range keys from in-memory index tree' (duration: 227.296201ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:37.827939Z","caller":"traceutil/trace.go:172","msg":"trace[1509543926] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"627.289291ms","start":"2026-03-17T20:45:37.200594Z","end":"2026-03-17T20:45:37.827884Z","steps":["trace[1509543926] 'process raft request' (duration: 627.156377ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.827938Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.011096Z","time spent":"816.824218ms","remote":"127.0.0.1:47944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:37.828129Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.200584Z","time spent":"627.434495ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.828618Z","caller":"traceutil/trace.go:172","msg":"trace[1585765246] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"633.285431ms","start":"2026-03-17T20:45:37.194864Z","end":"2026-03-17T20:45:37.828149Z","steps":["trace[1585765246] 'process raft request' (duration: 403.884611ms)","trace[1585765246] 'compare' (duration: 227.477156ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:37.828829Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.194815Z","time spent":"633.937959ms","remote":"127.0.0.1:48586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":706,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.828997Z","caller":"traceutil/trace.go:172","msg":"trace[556822974] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"632.248212ms","start":"2026-03-17T20:45:37.196639Z","end":"2026-03-17T20:45:37.828887Z","steps":["trace[556822974] 'process raft request' (duration: 629.815953ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.829319Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.196623Z","time spent":"632.423316ms","remote":"127.0.0.1:47886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":326,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.829347Z","caller":"traceutil/trace.go:172","msg":"trace[542716100] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"632.388406ms","start":"2026-03-17T20:45:37.196923Z","end":"2026-03-17T20:45:37.829312Z","steps":["trace[542716100] 'process raft request' (duration: 629.581976ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.829953Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.196904Z","time spent":"632.745945ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.831440Z","caller":"traceutil/trace.go:172","msg":"trace[876557623] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"630.871972ms","start":"2026-03-17T20:45:37.200546Z","end":"2026-03-17T20:45:37.831418Z","steps":["trace[876557623] 'process raft request' (duration: 627.051514ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.831595Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.200537Z","time spent":"630.946384ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.831556Z","caller":"traceutil/trace.go:172","msg":"trace[507900675] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"631.211401ms","start":"2026-03-17T20:45:37.200316Z","end":"2026-03-17T20:45:37.831527Z","steps":["trace[507900675] 'process raft request' (duration: 626.281752ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.832841Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.200306Z","time spent":"631.507821ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3206,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:45:37.836310Z","caller":"traceutil/trace.go:172","msg":"trace[1813504877] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"636.272915ms","start":"2026-03-17T20:45:37.199324Z","end":"2026-03-17T20:45:37.831269Z","steps":["trace[1813504877] 'process raft request' (duration: 627.219648ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.836427Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.199280Z","time spent":"637.079938ms","remote":"127.0.0.1:48306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":586,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:45:37.838383Z","caller":"traceutil/trace.go:172","msg":"trace[622365704] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"637.43376ms","start":"2026-03-17T20:45:37.200920Z","end":"2026-03-17T20:45:37.838354Z","steps":["trace[622365704] 'process raft request' (duration: 631.8181ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.838723Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.200911Z","time spent":"637.780509ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:37.850288Z","caller":"traceutil/trace.go:172","msg":"trace[528542890] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"390.573662ms","start":"2026-03-17T20:45:37.459695Z","end":"2026-03-17T20:45:37.850268Z","steps":["trace[528542890] 'process raft request' (duration: 390.540291ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:37.850389Z","caller":"traceutil/trace.go:172","msg":"trace[677681315] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"391.831318ms","start":"2026-03-17T20:45:37.458545Z","end":"2026-03-17T20:45:37.850377Z","steps":["trace[677681315] 'process raft request' (duration: 391.604842ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:37.850436Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.459678Z","time spent":"390.667524ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:37.850457Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:37.458523Z","time spent":"391.89989ms","remote":"127.0.0.1:48514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:38.075532Z","caller":"traceutil/trace.go:172","msg":"trace[920320541] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"150.032645ms","start":"2026-03-17T20:45:37.925476Z","end":"2026-03-17T20:45:38.075509Z","steps":["trace[920320541] 'process raft request' (duration: 149.901661ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:38.075695Z","caller":"traceutil/trace.go:172","msg":"trace[345019404] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"151.25869ms","start":"2026-03-17T20:45:37.924421Z","end":"2026-03-17T20:45:38.075680Z","steps":["trace[345019404] 'process raft request' (duration: 150.871608ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:38.075583Z","caller":"traceutil/trace.go:172","msg":"trace[1886079378] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"151.759924ms","start":"2026-03-17T20:45:37.923794Z","end":"2026-03-17T20:45:38.075554Z","steps":["trace[1886079378] 'process raft request' (duration: 62.360733ms)","trace[1886079378] 'compare' (duration: 88.928887ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:43.074656Z","caller":"traceutil/trace.go:172","msg":"trace[1477080474] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"102.050844ms","start":"2026-03-17T20:45:42.972579Z","end":"2026-03-17T20:45:43.074630Z","steps":["trace[1477080474] 'process raft request' (duration: 52.901586ms)","trace[1477080474] 'compare' (duration: 49.013395ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:43.990611Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"291.57886ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:43.990697Z","caller":"traceutil/trace.go:172","msg":"trace[953108249] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:338; }","duration":"291.676563ms","start":"2026-03-17T20:45:43.699004Z","end":"2026-03-17T20:45:43.990680Z","steps":["trace[953108249] 'range keys from in-memory index tree' (duration: 291.476507ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:44.296280Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.081569421s","expected-duration":"1s"} {"level":"info","ts":"2026-03-17T20:45:44.296500Z","caller":"traceutil/trace.go:172","msg":"trace[1309634118] linearizableReadLoop","detail":"{readStateIndex:350; appliedIndex:350; }","duration":"305.725865ms","start":"2026-03-17T20:45:43.990753Z","end":"2026-03-17T20:45:44.296479Z","steps":["trace[1309634118] 'read index received' (duration: 305.718125ms)","trace[1309634118] 'applied index is now lower than readState.Index' (duration: 6.44µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:44.296677Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"305.91123ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:44.296724Z","caller":"traceutil/trace.go:172","msg":"trace[1418758365] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:338; }","duration":"305.977751ms","start":"2026-03-17T20:45:43.990734Z","end":"2026-03-17T20:45:44.296712Z","steps":["trace[1418758365] 'agreement among raft nodes before linearized reading' (duration: 305.880229ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:44.296957Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"141.861283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:44.297026Z","caller":"traceutil/trace.go:172","msg":"trace[1568989415] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:339; }","duration":"141.944446ms","start":"2026-03-17T20:45:44.155070Z","end":"2026-03-17T20:45:44.297014Z","steps":["trace[1568989415] 'agreement among raft nodes before linearized reading' (duration: 141.840213ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:44.297128Z","caller":"traceutil/trace.go:172","msg":"trace[31710291] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"1.082467425s","start":"2026-03-17T20:45:43.214648Z","end":"2026-03-17T20:45:44.297115Z","steps":["trace[31710291] 'process raft request' (duration: 1.082151527s)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:44.297203Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:43.214634Z","time spent":"1.082527948s","remote":"127.0.0.1:48052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:45:44.715377Z","caller":"traceutil/trace.go:172","msg":"trace[813008173] linearizableReadLoop","detail":"{readStateIndex:351; appliedIndex:351; }","duration":"412.878552ms","start":"2026-03-17T20:45:44.302471Z","end":"2026-03-17T20:45:44.715350Z","steps":["trace[813008173] 'read index received' (duration: 412.872152ms)","trace[813008173] 'applied index is now lower than readState.Index' (duration: 5.14µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:44.766516Z","caller":"traceutil/trace.go:172","msg":"trace[1069778100] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"465.215112ms","start":"2026-03-17T20:45:44.301271Z","end":"2026-03-17T20:45:44.766486Z","steps":["trace[1069778100] 'process raft request' (duration: 414.186258ms)","trace[1069778100] 'compare' (duration: 50.800688ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:44.766487Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"463.951967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-controller\" limit:1 ","response":"range_response_count:1 size:5955"} {"level":"warn","ts":"2026-03-17T20:45:44.766630Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:44.301250Z","time spent":"465.329965ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:44.766631Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"463.229967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-03-17T20:45:44.766593Z","caller":"traceutil/trace.go:172","msg":"trace[269604115] range","detail":"{range_begin:/registry/pods/kube-system/etcd-controller; range_end:; response_count:1; response_revision:339; }","duration":"464.106902ms","start":"2026-03-17T20:45:44.302467Z","end":"2026-03-17T20:45:44.766574Z","steps":["trace[269604115] 'agreement among raft nodes before linearized reading' (duration: 412.999536ms)","trace[269604115] 'range keys from in-memory index tree' (duration: 50.607173ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:44.766706Z","caller":"traceutil/trace.go:172","msg":"trace[742819392] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:340; }","duration":"463.32371ms","start":"2026-03-17T20:45:44.303365Z","end":"2026-03-17T20:45:44.766688Z","steps":["trace[742819392] 'agreement among raft nodes before linearized reading' (duration: 463.114894ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:44.766747Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:44.303338Z","time spent":"463.398252ms","remote":"127.0.0.1:48052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:44.766743Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:44.302458Z","time spent":"464.268227ms","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":5978,"request content":"key:\"/registry/pods/kube-system/etcd-controller\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:45.224095Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"433.169343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-17T20:45:45.224171Z","caller":"traceutil/trace.go:172","msg":"trace[1924289446] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:341; }","duration":"433.241425ms","start":"2026-03-17T20:45:44.790909Z","end":"2026-03-17T20:45:45.224151Z","steps":["trace[1924289446] 'agreement among raft nodes before linearized reading' (duration: 99.501307ms)","trace[1924289446] 'range keys from in-memory index tree' (duration: 332.812122ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:45.224210Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:44.790890Z","time spent":"433.311627ms","remote":"127.0.0.1:47886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:45.223728Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"332.41976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-17T20:45:45.224448Z","caller":"traceutil/trace.go:172","msg":"trace[1336416074] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"445.502642ms","start":"2026-03-17T20:45:44.778935Z","end":"2026-03-17T20:45:45.224438Z","steps":["trace[1336416074] 'process raft request' (duration: 445.43152ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:45.224524Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:44.778925Z","time spent":"445.562165ms","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5768,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:45:45.224631Z","caller":"traceutil/trace.go:172","msg":"trace[1464673636] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"451.289173ms","start":"2026-03-17T20:45:44.773291Z","end":"2026-03-17T20:45:45.224580Z","steps":["trace[1464673636] 'process raft request' (duration: 117.962457ms)","trace[1464673636] 'compare' (duration: 332.321828ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:45.224828Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:44.773263Z","time spent":"451.483079ms","remote":"127.0.0.1:47818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":707,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:45.634393Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"300.684818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T20:45:45.634601Z","caller":"traceutil/trace.go:172","msg":"trace[1839418911] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"404.960775ms","start":"2026-03-17T20:45:45.229625Z","end":"2026-03-17T20:45:45.634586Z","steps":["trace[1839418911] 'process raft request' (duration: 404.880843ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:45.634607Z","caller":"traceutil/trace.go:172","msg":"trace[1191108850] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"552.374374ms","start":"2026-03-17T20:45:45.082204Z","end":"2026-03-17T20:45:45.634579Z","steps":["trace[1191108850] 'process raft request' (duration: 251.411498ms)","trace[1191108850] 'compare' (duration: 299.912556ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:45.634666Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:45.229598Z","time spent":"405.045387ms","remote":"127.0.0.1:48052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:45.634976Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:45.082111Z","time spent":"552.562028ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T20:45:45.898821Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"164.868097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/validatingadmissionpolicy-status-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:45.898910Z","caller":"traceutil/trace.go:172","msg":"trace[468236894] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/validatingadmissionpolicy-status-controller; range_end:; response_count:0; response_revision:346; }","duration":"164.97566ms","start":"2026-03-17T20:45:45.733913Z","end":"2026-03-17T20:45:45.898889Z","steps":["trace[468236894] 'range keys from in-memory index tree' (duration: 164.753985ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:46.083898Z","caller":"traceutil/trace.go:172","msg":"trace[1485599835] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"176.982249ms","start":"2026-03-17T20:45:45.906896Z","end":"2026-03-17T20:45:46.083879Z","steps":["trace[1485599835] 'process raft request' (duration: 176.890527ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:46.343814Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"157.503626ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T20:45:46.344027Z","caller":"traceutil/trace.go:172","msg":"trace[1220329829] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"246.385201ms","start":"2026-03-17T20:45:46.097620Z","end":"2026-03-17T20:45:46.344005Z","steps":["trace[1220329829] 'process raft request' (duration: 246.311239ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:46.344028Z","caller":"traceutil/trace.go:172","msg":"trace[678947148] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"247.053748ms","start":"2026-03-17T20:45:46.096955Z","end":"2026-03-17T20:45:46.344009Z","steps":["trace[678947148] 'process raft request' (duration: 89.246344ms)","trace[678947148] 'compare' (duration: 157.388083ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:46.848029Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"148.530622ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:46.848095Z","caller":"traceutil/trace.go:172","msg":"trace[130627914] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:353; }","duration":"148.613114ms","start":"2026-03-17T20:45:46.699469Z","end":"2026-03-17T20:45:46.848082Z","steps":["trace[130627914] 'range keys from in-memory index tree' (duration: 148.47804ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:46.917623Z","caller":"traceutil/trace.go:172","msg":"trace[1188313341] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:365; }","duration":"275.765633ms","start":"2026-03-17T20:45:46.641818Z","end":"2026-03-17T20:45:46.917584Z","steps":["trace[1188313341] 'read index received' (duration: 275.757993ms)","trace[1188313341] 'applied index is now lower than readState.Index' (duration: 6.4µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:46.917855Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"276.014659ms","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-03-17T20:45:46.917882Z","caller":"traceutil/trace.go:172","msg":"trace[1573997653] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:353; }","duration":"276.059261ms","start":"2026-03-17T20:45:46.641813Z","end":"2026-03-17T20:45:46.917872Z","steps":["trace[1573997653] 'agreement among raft nodes before linearized reading' (duration: 275.910187ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:46.918045Z","caller":"traceutil/trace.go:172","msg":"trace[395065047] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"288.191931ms","start":"2026-03-17T20:45:46.629836Z","end":"2026-03-17T20:45:46.918028Z","steps":["trace[395065047] 'process raft request' (duration: 288.070337ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.097579Z","caller":"traceutil/trace.go:172","msg":"trace[226412696] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:366; }","duration":"179.820294ms","start":"2026-03-17T20:45:46.917706Z","end":"2026-03-17T20:45:47.097526Z","steps":["trace[226412696] 'read index received' (duration: 179.799463ms)","trace[226412696] 'applied index is now lower than readState.Index' (duration: 18.461µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:47.097653Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"249.488944ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:47.097786Z","caller":"traceutil/trace.go:172","msg":"trace[415954073] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:354; }","duration":"249.639698ms","start":"2026-03-17T20:45:46.848124Z","end":"2026-03-17T20:45:47.097763Z","steps":["trace[415954073] 'agreement among raft nodes before linearized reading' (duration: 249.412392ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.097907Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"385.944947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:47.097967Z","caller":"traceutil/trace.go:172","msg":"trace[389122281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:356; }","duration":"386.023329ms","start":"2026-03-17T20:45:46.711930Z","end":"2026-03-17T20:45:47.097953Z","steps":["trace[389122281] 'agreement among raft nodes before linearized reading' (duration: 385.877595ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.098090Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.711917Z","time spent":"386.158292ms","remote":"127.0.0.1:47722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-17T20:45:47.098166Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"439.434525ms","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-03-17T20:45:47.098212Z","caller":"traceutil/trace.go:172","msg":"trace[1077195636] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:358; }","duration":"439.485197ms","start":"2026-03-17T20:45:46.658715Z","end":"2026-03-17T20:45:47.098201Z","steps":["trace[1077195636] 'agreement among raft nodes before linearized reading' (duration: 439.306632ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.098278Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.658704Z","time spent":"439.56453ms","remote":"127.0.0.1:48052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 "} {"level":"info","ts":"2026-03-17T20:45:47.098314Z","caller":"traceutil/trace.go:172","msg":"trace[932249011] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"466.75127ms","start":"2026-03-17T20:45:46.631536Z","end":"2026-03-17T20:45:47.098287Z","steps":["trace[932249011] 'process raft request' (duration: 466.022811ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.098430Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.631510Z","time spent":"466.849813ms","remote":"127.0.0.1:48688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2102,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:45:47.098555Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"442.439137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/controller\" limit:1 ","response":"range_response_count:1 size:544"} {"level":"warn","ts":"2026-03-17T20:45:47.098571Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"423.914891ms","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":"info","ts":"2026-03-17T20:45:47.098616Z","caller":"traceutil/trace.go:172","msg":"trace[663759330] range","detail":"{range_begin:/registry/leases/kube-node-lease/controller; range_end:; response_count:1; response_revision:358; }","duration":"442.501669ms","start":"2026-03-17T20:45:46.656102Z","end":"2026-03-17T20:45:47.098603Z","steps":["trace[663759330] 'agreement among raft nodes before linearized reading' (duration: 442.321334ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.098650Z","caller":"traceutil/trace.go:172","msg":"trace[1017032520] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:358; }","duration":"423.996864ms","start":"2026-03-17T20:45:46.674643Z","end":"2026-03-17T20:45:47.098640Z","steps":["trace[1017032520] 'agreement among raft nodes before linearized reading' (duration: 423.84829ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.098668Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.656081Z","time spent":"442.5776ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":567,"request content":"key:\"/registry/leases/kube-node-lease/controller\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:47.098682Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.674631Z","time spent":"424.040536ms","remote":"127.0.0.1:48052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:47.098605Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"423.018798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-03-17T20:45:47.098874Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"443.041405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-acutp8\" limit:1 ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-03-17T20:45:47.098911Z","caller":"traceutil/trace.go:172","msg":"trace[891941004] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-acutp8; range_end:; response_count:1; response_revision:358; }","duration":"443.078416ms","start":"2026-03-17T20:45:46.655823Z","end":"2026-03-17T20:45:47.098902Z","steps":["trace[891941004] 'agreement among raft nodes before linearized reading' (duration: 442.987083ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.098937Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.655810Z","time spent":"443.119136ms","remote":"127.0.0.1:47862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":563,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-acutp8\" limit:1 "} {"level":"info","ts":"2026-03-17T20:45:47.097973Z","caller":"traceutil/trace.go:172","msg":"trace[1962318070] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"303.928779ms","start":"2026-03-17T20:45:46.794016Z","end":"2026-03-17T20:45:47.097944Z","steps":["trace[1962318070] 'process raft request' (duration: 303.878998ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.098772Z","caller":"traceutil/trace.go:172","msg":"trace[1118533577] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:358; }","duration":"423.244235ms","start":"2026-03-17T20:45:46.675511Z","end":"2026-03-17T20:45:47.098755Z","steps":["trace[1118533577] 'agreement among raft nodes before linearized reading' (duration: 422.930215ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.099060Z","caller":"traceutil/trace.go:172","msg":"trace[854571951] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"466.845974ms","start":"2026-03-17T20:45:46.632204Z","end":"2026-03-17T20:45:47.099050Z","steps":["trace[854571951] 'process raft request' (duration: 465.562198ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.099129Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.632195Z","time spent":"466.894645ms","remote":"127.0.0.1:48306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":805,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:45:47.099324Z","caller":"traceutil/trace.go:172","msg":"trace[1761329415] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"465.340512ms","start":"2026-03-17T20:45:46.633977Z","end":"2026-03-17T20:45:47.099317Z","steps":["trace[1761329415] 'process raft request' (duration: 463.858561ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.099360Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.633968Z","time spent":"465.372243ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4017,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T20:45:47.099056Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.675493Z","time spent":"423.548292ms","remote":"127.0.0.1:48052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:47.099639Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"419.482701ms","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-03-17T20:45:47.099645Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"408.979274ms","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-03-17T20:45:47.099677Z","caller":"traceutil/trace.go:172","msg":"trace[1153333306] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:358; }","duration":"419.524942ms","start":"2026-03-17T20:45:46.680144Z","end":"2026-03-17T20:45:47.099669Z","steps":["trace[1153333306] 'agreement among raft nodes before linearized reading' (duration: 419.425349ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.099703Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.680131Z","time spent":"419.564664ms","remote":"127.0.0.1:48052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:47.099751Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"177.070588ms","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-03-17T20:45:47.099783Z","caller":"traceutil/trace.go:172","msg":"trace[1443381487] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:358; }","duration":"177.101499ms","start":"2026-03-17T20:45:46.922672Z","end":"2026-03-17T20:45:47.099773Z","steps":["trace[1443381487] 'agreement among raft nodes before linearized reading' (duration: 176.976126ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.099939Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"448.823061ms","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-03-17T20:45:47.099975Z","caller":"traceutil/trace.go:172","msg":"trace[665229903] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:358; }","duration":"448.860682ms","start":"2026-03-17T20:45:46.651106Z","end":"2026-03-17T20:45:47.099967Z","steps":["trace[665229903] 'agreement among raft nodes before linearized reading' (duration: 448.76955ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.099999Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.651082Z","time spent":"448.910164ms","remote":"127.0.0.1:48052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:45:47.100588Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.793951Z","time spent":"305.08895ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:45:47.099692Z","caller":"traceutil/trace.go:172","msg":"trace[1965990925] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:358; }","duration":"409.027065ms","start":"2026-03-17T20:45:46.690652Z","end":"2026-03-17T20:45:47.099679Z","steps":["trace[1965990925] 'agreement among raft nodes before linearized reading' (duration: 408.894482ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.101458Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:46.690644Z","time spent":"410.796414ms","remote":"127.0.0.1:48052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" limit:1 "} {"level":"info","ts":"2026-03-17T20:45:47.313089Z","caller":"traceutil/trace.go:172","msg":"trace[787693682] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:382; }","duration":"122.235401ms","start":"2026-03-17T20:45:47.190820Z","end":"2026-03-17T20:45:47.313055Z","steps":["trace[787693682] 'read index received' (duration: 122.22287ms)","trace[787693682] 'applied index is now lower than readState.Index' (duration: 10.4µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:47.400394Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"209.550802ms","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":"info","ts":"2026-03-17T20:45:47.400485Z","caller":"traceutil/trace.go:172","msg":"trace[388053017] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:370; }","duration":"209.649545ms","start":"2026-03-17T20:45:47.190814Z","end":"2026-03-17T20:45:47.400463Z","steps":["trace[388053017] 'agreement among raft nodes before linearized reading' (duration: 122.364844ms)","trace[388053017] 'range keys from in-memory index tree' (duration: 87.043935ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:47.401267Z","caller":"traceutil/trace.go:172","msg":"trace[2000339802] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"214.104886ms","start":"2026-03-17T20:45:47.187118Z","end":"2026-03-17T20:45:47.401223Z","steps":["trace[2000339802] 'process raft request' (duration: 126.050414ms)","trace[2000339802] 'compare' (duration: 87.876946ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:47.401538Z","caller":"traceutil/trace.go:172","msg":"trace[525346284] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"211.233768ms","start":"2026-03-17T20:45:47.190127Z","end":"2026-03-17T20:45:47.401361Z","steps":["trace[525346284] 'process raft request' (duration: 211.177586ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.401550Z","caller":"traceutil/trace.go:172","msg":"trace[436218792] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"212.210244ms","start":"2026-03-17T20:45:47.189305Z","end":"2026-03-17T20:45:47.401515Z","steps":["trace[436218792] 'process raft request' (duration: 211.864824ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.401641Z","caller":"traceutil/trace.go:172","msg":"trace[1117692631] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"212.021579ms","start":"2026-03-17T20:45:47.189586Z","end":"2026-03-17T20:45:47.401608Z","steps":["trace[1117692631] 'process raft request' (duration: 211.627128ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.401670Z","caller":"traceutil/trace.go:172","msg":"trace[919419894] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"211.752941ms","start":"2026-03-17T20:45:47.189892Z","end":"2026-03-17T20:45:47.401644Z","steps":["trace[919419894] 'process raft request' (duration: 211.375631ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.402350Z","caller":"traceutil/trace.go:172","msg":"trace[1337016500] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"211.950047ms","start":"2026-03-17T20:45:47.190348Z","end":"2026-03-17T20:45:47.402299Z","steps":["trace[1337016500] 'process raft request' (duration: 210.988111ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.402585Z","caller":"traceutil/trace.go:172","msg":"trace[1254306524] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"211.940367ms","start":"2026-03-17T20:45:47.190623Z","end":"2026-03-17T20:45:47.402563Z","steps":["trace[1254306524] 'process raft request' (duration: 211.344891ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.402628Z","caller":"traceutil/trace.go:172","msg":"trace[1610762726] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"208.536953ms","start":"2026-03-17T20:45:47.194067Z","end":"2026-03-17T20:45:47.402604Z","steps":["trace[1610762726] 'process raft request' (duration: 208.487962ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.402745Z","caller":"traceutil/trace.go:172","msg":"trace[724250627] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"209.549761ms","start":"2026-03-17T20:45:47.193182Z","end":"2026-03-17T20:45:47.402731Z","steps":["trace[724250627] 'process raft request' (duration: 209.318535ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.592499Z","caller":"traceutil/trace.go:172","msg":"trace[1315985779] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"177.840641ms","start":"2026-03-17T20:45:47.414640Z","end":"2026-03-17T20:45:47.592481Z","steps":["trace[1315985779] 'process raft request' (duration: 177.80548ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.592582Z","caller":"traceutil/trace.go:172","msg":"trace[781211791] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"181.845229ms","start":"2026-03-17T20:45:47.410705Z","end":"2026-03-17T20:45:47.592550Z","steps":["trace[781211791] 'process raft request' (duration: 181.687825ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.592670Z","caller":"traceutil/trace.go:172","msg":"trace[271019576] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"179.533237ms","start":"2026-03-17T20:45:47.413113Z","end":"2026-03-17T20:45:47.592646Z","steps":["trace[271019576] 'process raft request' (duration: 179.312731ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.592755Z","caller":"traceutil/trace.go:172","msg":"trace[557911724] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"183.060231ms","start":"2026-03-17T20:45:47.409645Z","end":"2026-03-17T20:45:47.592705Z","steps":["trace[557911724] 'process raft request' (duration: 178.961979ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.592800Z","caller":"traceutil/trace.go:172","msg":"trace[1516268235] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"181.984902ms","start":"2026-03-17T20:45:47.410504Z","end":"2026-03-17T20:45:47.592488Z","steps":["trace[1516268235] 'process raft request' (duration: 181.852169ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.674544Z","caller":"traceutil/trace.go:172","msg":"trace[1588789959] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"225.028191ms","start":"2026-03-17T20:45:47.449495Z","end":"2026-03-17T20:45:47.674523Z","steps":["trace[1588789959] 'process raft request' (duration: 224.96344ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.674914Z","caller":"traceutil/trace.go:172","msg":"trace[163065150] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"228.707672ms","start":"2026-03-17T20:45:47.446169Z","end":"2026-03-17T20:45:47.674876Z","steps":["trace[163065150] 'process raft request' (duration: 228.192758ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.822102Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"123.264398ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:47.822691Z","caller":"traceutil/trace.go:172","msg":"trace[1762520290] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"181.767367ms","start":"2026-03-17T20:45:47.640909Z","end":"2026-03-17T20:45:47.822676Z","steps":["trace[1762520290] 'process raft request' (duration: 181.730266ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.822900Z","caller":"traceutil/trace.go:172","msg":"trace[1852371416] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"225.411252ms","start":"2026-03-17T20:45:47.597477Z","end":"2026-03-17T20:45:47.822889Z","steps":["trace[1852371416] 'process raft request' (duration: 172.484574ms)","trace[1852371416] 'compare' (duration: 52.046644ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:47.822968Z","caller":"traceutil/trace.go:172","msg":"trace[1504995596] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"224.58707ms","start":"2026-03-17T20:45:47.598375Z","end":"2026-03-17T20:45:47.822962Z","steps":["trace[1504995596] 'process raft request' (duration: 224.082246ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.823132Z","caller":"traceutil/trace.go:172","msg":"trace[1440106107] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"223.179732ms","start":"2026-03-17T20:45:47.599946Z","end":"2026-03-17T20:45:47.823126Z","steps":["trace[1440106107] 'process raft request' (duration: 222.550885ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.823212Z","caller":"traceutil/trace.go:172","msg":"trace[11563739] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"222.477152ms","start":"2026-03-17T20:45:47.600728Z","end":"2026-03-17T20:45:47.823206Z","steps":["trace[11563739] 'process raft request' (duration: 221.802014ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.823285Z","caller":"traceutil/trace.go:172","msg":"trace[742661090] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"214.512095ms","start":"2026-03-17T20:45:47.608767Z","end":"2026-03-17T20:45:47.823279Z","steps":["trace[742661090] 'process raft request' (duration: 213.826417ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.822506Z","caller":"traceutil/trace.go:172","msg":"trace[544581969] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:387; }","duration":"123.671349ms","start":"2026-03-17T20:45:47.698810Z","end":"2026-03-17T20:45:47.822482Z","steps":["trace[544581969] 'range keys from in-memory index tree' (duration: 123.194066ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:47.822388Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"120.361349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" limit:1 ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-03-17T20:45:47.824469Z","caller":"traceutil/trace.go:172","msg":"trace[561568588] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:387; }","duration":"122.441876ms","start":"2026-03-17T20:45:47.702004Z","end":"2026-03-17T20:45:47.824446Z","steps":["trace[561568588] 'agreement among raft nodes before linearized reading' (duration: 67.879013ms)","trace[561568588] 'range keys from in-memory index tree' (duration: 52.367953ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:47.837131Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"123.827243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:47.837201Z","caller":"traceutil/trace.go:172","msg":"trace[281961765] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:393; }","duration":"123.904105ms","start":"2026-03-17T20:45:47.713283Z","end":"2026-03-17T20:45:47.837187Z","steps":["trace[281961765] 'agreement among raft nodes before linearized reading' (duration: 123.789532ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.837463Z","caller":"traceutil/trace.go:172","msg":"trace[660381897] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"155.005599ms","start":"2026-03-17T20:45:47.682438Z","end":"2026-03-17T20:45:47.837443Z","steps":["trace[660381897] 'process raft request' (duration: 154.768773ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:47.945199Z","caller":"traceutil/trace.go:172","msg":"trace[1430426200] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:406; }","duration":"108.122698ms","start":"2026-03-17T20:45:47.837045Z","end":"2026-03-17T20:45:47.945168Z","steps":["trace[1430426200] 'read index received' (duration: 108.074856ms)","trace[1430426200] 'applied index is now lower than readState.Index' (duration: 46.092µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:48.006992Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"182.548967ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:48.007052Z","caller":"traceutil/trace.go:172","msg":"trace[1048401694] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:394; }","duration":"182.619089ms","start":"2026-03-17T20:45:47.824419Z","end":"2026-03-17T20:45:48.007038Z","steps":["trace[1048401694] 'agreement among raft nodes before linearized reading' (duration: 120.849922ms)","trace[1048401694] 'range keys from in-memory index tree' (duration: 61.685315ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:48.007165Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"181.085838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-7hb27\" limit:1 ","response":"range_response_count:1 size:5040"} {"level":"info","ts":"2026-03-17T20:45:48.007284Z","caller":"traceutil/trace.go:172","msg":"trace[139314142] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-7hb27; range_end:; response_count:1; response_revision:394; }","duration":"181.244042ms","start":"2026-03-17T20:45:47.826014Z","end":"2026-03-17T20:45:48.007258Z","steps":["trace[139314142] 'agreement among raft nodes before linearized reading' (duration: 119.156407ms)","trace[139314142] 'range keys from in-memory index tree' (duration: 61.840539ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:48.007554Z","caller":"traceutil/trace.go:172","msg":"trace[407802598] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"179.350041ms","start":"2026-03-17T20:45:47.828196Z","end":"2026-03-17T20:45:48.007546Z","steps":["trace[407802598] 'process raft request' (duration: 179.100854ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:48.007574Z","caller":"traceutil/trace.go:172","msg":"trace[2144406169] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"186.238808ms","start":"2026-03-17T20:45:47.821294Z","end":"2026-03-17T20:45:48.007533Z","steps":["trace[2144406169] 'process raft request' (duration: 123.882696ms)","trace[2144406169] 'compare' (duration: 61.718895ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:48.007667Z","caller":"traceutil/trace.go:172","msg":"trace[57222413] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"177.540471ms","start":"2026-03-17T20:45:47.830090Z","end":"2026-03-17T20:45:48.007631Z","steps":["trace[57222413] 'process raft request' (duration: 177.459039ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:48.007776Z","caller":"traceutil/trace.go:172","msg":"trace[1067362778] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"176.559065ms","start":"2026-03-17T20:45:47.831212Z","end":"2026-03-17T20:45:48.007771Z","steps":["trace[1067362778] 'process raft request' (duration: 176.36697ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:48.007694Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"169.495463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:48.007936Z","caller":"traceutil/trace.go:172","msg":"trace[1431173360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:399; }","duration":"169.73962ms","start":"2026-03-17T20:45:47.838186Z","end":"2026-03-17T20:45:48.007925Z","steps":["trace[1431173360] 'agreement among raft nodes before linearized reading' (duration: 169.438692ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:48.007971Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"167.17468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 ","response":"range_response_count:1 size:4948"} {"level":"info","ts":"2026-03-17T20:45:48.008044Z","caller":"traceutil/trace.go:172","msg":"trace[1147096357] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-controller; range_end:; response_count:1; response_revision:399; }","duration":"167.219081ms","start":"2026-03-17T20:45:47.840786Z","end":"2026-03-17T20:45:48.008005Z","steps":["trace[1147096357] 'agreement among raft nodes before linearized reading' (duration: 167.038536ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:48.010343Z","caller":"traceutil/trace.go:172","msg":"trace[1130185856] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"177.971623ms","start":"2026-03-17T20:45:47.829908Z","end":"2026-03-17T20:45:48.007880Z","steps":["trace[1130185856] 'process raft request' (duration: 177.580652ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:48.320452Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"108.262778ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T20:45:48.320542Z","caller":"traceutil/trace.go:172","msg":"trace[1691412125] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"303.734336ms","start":"2026-03-17T20:45:48.016795Z","end":"2026-03-17T20:45:48.320529Z","steps":["trace[1691412125] 'process raft request' (duration: 195.342124ms)","trace[1691412125] 'compare' (duration: 108.161216ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:48.320587Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:48.016771Z","time spent":"303.795447ms","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4741,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:45:48.338560Z","caller":"traceutil/trace.go:172","msg":"trace[1707458490] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"321.103105ms","start":"2026-03-17T20:45:48.017439Z","end":"2026-03-17T20:45:48.338542Z","steps":["trace[1707458490] 'process raft request' (duration: 320.979941ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:48.338696Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:48.017416Z","time spent":"321.211338ms","remote":"127.0.0.1:48666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4086,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T20:45:49.336690Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"890.075984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T20:45:49.336795Z","caller":"traceutil/trace.go:172","msg":"trace[889066739] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:413; }","duration":"638.075017ms","start":"2026-03-17T20:45:48.698705Z","end":"2026-03-17T20:45:49.336780Z","steps":["trace[889066739] 'read index received' (duration: 49.721µs)","trace[889066739] 'applied index is now lower than readState.Index' (duration: 638.024076ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:49.336873Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"638.188631ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:49.336857Z","caller":"traceutil/trace.go:172","msg":"trace[244879694] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"990.249672ms","start":"2026-03-17T20:45:48.346568Z","end":"2026-03-17T20:45:49.336818Z","steps":["trace[244879694] 'process raft request' (duration: 99.958464ms)","trace[244879694] 'compare' (duration: 889.911058ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:49.336921Z","caller":"traceutil/trace.go:172","msg":"trace[425125024] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:402; }","duration":"638.247213ms","start":"2026-03-17T20:45:48.698660Z","end":"2026-03-17T20:45:49.336907Z","steps":["trace[425125024] 'agreement among raft nodes before linearized reading' (duration: 638.164501ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:49.337022Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:48.346548Z","time spent":"990.394637ms","remote":"127.0.0.1:48602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4323,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:45:49.458686Z","caller":"traceutil/trace.go:172","msg":"trace[1252920370] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:414; }","duration":"121.845212ms","start":"2026-03-17T20:45:49.336820Z","end":"2026-03-17T20:45:49.458665Z","steps":["trace[1252920370] 'read index received' (duration: 121.839752ms)","trace[1252920370] 'applied index is now lower than readState.Index' (duration: 4.67µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:49.587052Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"873.715012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:49.587144Z","caller":"traceutil/trace.go:172","msg":"trace[683213774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:402; }","duration":"873.805286ms","start":"2026-03-17T20:45:48.713308Z","end":"2026-03-17T20:45:49.587114Z","steps":["trace[683213774] 'agreement among raft nodes before linearized reading' (duration: 745.453979ms)","trace[683213774] 'range keys from in-memory index tree' (duration: 128.233964ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:49.587185Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:48.713292Z","time spent":"873.884177ms","remote":"127.0.0.1:47740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-17T20:45:49.587256Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"128.425799ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T20:45:49.587348Z","caller":"traceutil/trace.go:172","msg":"trace[838839587] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:414; }","duration":"128.581293ms","start":"2026-03-17T20:45:49.458751Z","end":"2026-03-17T20:45:49.587332Z","steps":["trace[838839587] 'read index received' (duration: 25.491µs)","trace[838839587] 'applied index is now lower than readState.Index' (duration: 128.554402ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:49.587526Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"200.606203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-17T20:45:49.587550Z","caller":"traceutil/trace.go:172","msg":"trace[638233006] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"479.947856ms","start":"2026-03-17T20:45:49.107576Z","end":"2026-03-17T20:45:49.587524Z","steps":["trace[638233006] 'process raft request' (duration: 351.180037ms)","trace[638233006] 'compare' (duration: 128.279706ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:45:49.587578Z","caller":"traceutil/trace.go:172","msg":"trace[731744413] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:1; response_revision:403; }","duration":"200.666735ms","start":"2026-03-17T20:45:49.386899Z","end":"2026-03-17T20:45:49.587565Z","steps":["trace[731744413] 'agreement among raft nodes before linearized reading' (duration: 200.48185ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:49.587779Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:49.107541Z","time spent":"480.054728ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:45:50.986674Z","caller":"traceutil/trace.go:172","msg":"trace[1957818105] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:419; }","duration":"287.002796ms","start":"2026-03-17T20:45:50.699642Z","end":"2026-03-17T20:45:50.986645Z","steps":["trace[1957818105] 'read index received' (duration: 286.991566ms)","trace[1957818105] 'applied index is now lower than readState.Index' (duration: 9.28µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:45:50.986829Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"287.160381ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:50.986862Z","caller":"traceutil/trace.go:172","msg":"trace[1334494173] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:406; }","duration":"287.217563ms","start":"2026-03-17T20:45:50.699636Z","end":"2026-03-17T20:45:50.986854Z","steps":["trace[1334494173] 'agreement among raft nodes before linearized reading' (duration: 287.135641ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:45:50.986895Z","caller":"traceutil/trace.go:172","msg":"trace[393046127] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"483.842675ms","start":"2026-03-17T20:45:50.503036Z","end":"2026-03-17T20:45:50.986879Z","steps":["trace[393046127] 'process raft request' (duration: 483.701872ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:50.987014Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:50.502979Z","time spent":"483.971558ms","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7345,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T20:45:50.992745Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"277.409969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:45:50.992788Z","caller":"traceutil/trace.go:172","msg":"trace[2018712170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:407; }","duration":"277.452401ms","start":"2026-03-17T20:45:50.715325Z","end":"2026-03-17T20:45:50.992777Z","steps":["trace[2018712170] 'agreement among raft nodes before linearized reading' (duration: 277.348778ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:52.269395Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"196.378684ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-03-17T20:45:54.357071Z","caller":"traceutil/trace.go:172","msg":"trace[1926143830] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"420.810342ms","start":"2026-03-17T20:45:53.936244Z","end":"2026-03-17T20:45:54.357055Z","steps":["trace[1926143830] 'process raft request' (duration: 420.681218ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:45:54.357483Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:45:53.936222Z","time spent":"420.925475ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:02.577135Z","caller":"traceutil/trace.go:172","msg":"trace[972470872] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"163.971027ms","start":"2026-03-17T20:46:02.413144Z","end":"2026-03-17T20:46:02.577115Z","steps":["trace[972470872] 'process raft request' (duration: 163.849024ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:07.978669Z","caller":"traceutil/trace.go:172","msg":"trace[889072750] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"111.076455ms","start":"2026-03-17T20:46:07.867573Z","end":"2026-03-17T20:46:07.978650Z","steps":["trace[889072750] 'process raft request' (duration: 110.958712ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:08.101943Z","caller":"traceutil/trace.go:172","msg":"trace[25115731] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"165.086775ms","start":"2026-03-17T20:46:07.936839Z","end":"2026-03-17T20:46:08.101926Z","steps":["trace[25115731] 'process raft request' (duration: 113.265925ms)","trace[25115731] 'compare' (duration: 51.734798ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:08.190064Z","caller":"traceutil/trace.go:172","msg":"trace[128366335] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"204.15744ms","start":"2026-03-17T20:46:07.985887Z","end":"2026-03-17T20:46:08.190044Z","steps":["trace[128366335] 'process raft request' (duration: 204.061377ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:10.716938Z","caller":"traceutil/trace.go:172","msg":"trace[1165699256] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"104.647586ms","start":"2026-03-17T20:46:10.612267Z","end":"2026-03-17T20:46:10.716915Z","steps":["trace[1165699256] 'process raft request' (duration: 104.39993ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:21.689228Z","caller":"traceutil/trace.go:172","msg":"trace[622433160] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:502; }","duration":"116.037145ms","start":"2026-03-17T20:46:21.573165Z","end":"2026-03-17T20:46:21.689203Z","steps":["trace[622433160] 'read index received' (duration: 116.030415ms)","trace[622433160] 'applied index is now lower than readState.Index' (duration: 5.81µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:21.689408Z","caller":"traceutil/trace.go:172","msg":"trace[335158123] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"117.746026ms","start":"2026-03-17T20:46:21.571643Z","end":"2026-03-17T20:46:21.689389Z","steps":["trace[335158123] 'process raft request' (duration: 117.577552ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:21.689962Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.736472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cilium-operator\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:21.690202Z","caller":"traceutil/trace.go:172","msg":"trace[41679625] range","detail":"{range_begin:/registry/clusterrolebindings/cilium-operator; range_end:; response_count:0; response_revision:481; }","duration":"116.981068ms","start":"2026-03-17T20:46:21.573162Z","end":"2026-03-17T20:46:21.690143Z","steps":["trace[41679625] 'agreement among raft nodes before linearized reading' (duration: 116.128807ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:21.899159Z","caller":"traceutil/trace.go:172","msg":"trace[1514435497] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"137.271486ms","start":"2026-03-17T20:46:21.761866Z","end":"2026-03-17T20:46:21.899138Z","steps":["trace[1514435497] 'process raft request' (duration: 136.558989ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:22.291365Z","caller":"traceutil/trace.go:172","msg":"trace[318570967] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"105.281008ms","start":"2026-03-17T20:46:22.186057Z","end":"2026-03-17T20:46:22.291338Z","steps":["trace[318570967] 'process raft request' (duration: 100.258428ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:22.309556Z","caller":"traceutil/trace.go:172","msg":"trace[773806226] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"121.642392ms","start":"2026-03-17T20:46:22.187892Z","end":"2026-03-17T20:46:22.309534Z","steps":["trace[773806226] 'process raft request' (duration: 121.430407ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:22.309757Z","caller":"traceutil/trace.go:172","msg":"trace[1028447070] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"119.628804ms","start":"2026-03-17T20:46:22.190101Z","end":"2026-03-17T20:46:22.309730Z","steps":["trace[1028447070] 'process raft request' (duration: 119.380788ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:28.446014Z","caller":"traceutil/trace.go:172","msg":"trace[1384172841] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"117.716662ms","start":"2026-03-17T20:46:28.328284Z","end":"2026-03-17T20:46:28.446001Z","steps":["trace[1384172841] 'process raft request' (duration: 117.63136ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:32.710265Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"128.065685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T20:46:32.710521Z","caller":"traceutil/trace.go:172","msg":"trace[2011750927] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"250.736026ms","start":"2026-03-17T20:46:32.459772Z","end":"2026-03-17T20:46:32.710508Z","steps":["trace[2011750927] 'process raft request' (duration: 122.376464ms)","trace[2011750927] 'compare' (duration: 127.769879ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:33.348046Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208729734913759,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-17T20:46:33.848521Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208729734913759,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-17T20:46:33.991124Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.182892379s","expected-duration":"1s"} {"level":"info","ts":"2026-03-17T20:46:33.991366Z","caller":"traceutil/trace.go:172","msg":"trace[1710850113] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:557; }","duration":"1.14361327s","start":"2026-03-17T20:46:32.847725Z","end":"2026-03-17T20:46:33.991339Z","steps":["trace[1710850113] 'read index received' (duration: 1.14360672s)","trace[1710850113] 'applied index is now lower than readState.Index' (duration: 4.63µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:33.991614Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.143870117s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5l2kk\" limit:1 ","response":"range_response_count:1 size:18350"} {"level":"warn","ts":"2026-03-17T20:46:33.991624Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"292.284952ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:33.991675Z","caller":"traceutil/trace.go:172","msg":"trace[1984633408] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5l2kk; range_end:; response_count:1; response_revision:534; }","duration":"1.143948799s","start":"2026-03-17T20:46:32.847711Z","end":"2026-03-17T20:46:33.991659Z","steps":["trace[1984633408] 'agreement among raft nodes before linearized reading' (duration: 1.143719073s)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:33.991694Z","caller":"traceutil/trace.go:172","msg":"trace[301508749] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:535; }","duration":"292.366014ms","start":"2026-03-17T20:46:33.699311Z","end":"2026-03-17T20:46:33.991677Z","steps":["trace[301508749] 'agreement among raft nodes before linearized reading' (duration: 292.265312ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:33.991723Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:32.847686Z","time spent":"1.14402477s","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18373,"request content":"key:\"/registry/pods/kube-system/cilium-5l2kk\" limit:1 "} {"level":"info","ts":"2026-03-17T20:46:33.992044Z","caller":"traceutil/trace.go:172","msg":"trace[1404629707] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.183959054s","start":"2026-03-17T20:46:32.808073Z","end":"2026-03-17T20:46:33.992032Z","steps":["trace[1404629707] 'process raft request' (duration: 1.183372371s)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:33.992126Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:32.808037Z","time spent":"1.184040266s","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T20:46:33.992273Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"276.883432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:33.992322Z","caller":"traceutil/trace.go:172","msg":"trace[232213538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:535; }","duration":"276.928744ms","start":"2026-03-17T20:46:33.715381Z","end":"2026-03-17T20:46:33.992310Z","steps":["trace[232213538] 'agreement among raft nodes before linearized reading' (duration: 276.856892ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:34.987084Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208729734913763,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-17T20:46:35.077430Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.071137336s","expected-duration":"1s"} {"level":"info","ts":"2026-03-17T20:46:35.077900Z","caller":"traceutil/trace.go:172","msg":"trace[1119343778] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:558; }","duration":"591.423706ms","start":"2026-03-17T20:46:34.486418Z","end":"2026-03-17T20:46:35.077841Z","steps":["trace[1119343778] 'read index received' (duration: 591.377805ms)","trace[1119343778] 'applied index is now lower than readState.Index' (duration: 35.891µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:35.078007Z","caller":"traceutil/trace.go:172","msg":"trace[621055622] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.071861914s","start":"2026-03-17T20:46:34.006124Z","end":"2026-03-17T20:46:35.077986Z","steps":["trace[621055622] 'process raft request' (duration: 1.071628307s)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:35.078268Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:34.006094Z","time spent":"1.071980027s","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18507,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T20:46:35.578341Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208729734913766,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-17T20:46:36.079506Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208729734913766,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-17T20:46:36.580076Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208729734913766,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-17T20:46:36.717017Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000105497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-03-17T20:46:36.717117Z","caller":"traceutil/trace.go:172","msg":"trace[779361663] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00024175s","start":"2026-03-17T20:46:34.716855Z","end":"2026-03-17T20:46:36.717097Z","steps":["trace[779361663] 'agreement among raft nodes before linearized reading' (duration: 2.000099457s)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:36.717615Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:34.716832Z","time spent":"2.000767932s","remote":"127.0.0.1:47740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/03/17 20:46:36 WARNING: [core] [Server #5]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-03-17T20:46:37.080912Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208729734913766,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-17T20:46:37.293643Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.132819047s","expected-duration":"1s"} {"level":"info","ts":"2026-03-17T20:46:37.293974Z","caller":"traceutil/trace.go:172","msg":"trace[948518540] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:559; }","duration":"2.215886137s","start":"2026-03-17T20:46:35.078037Z","end":"2026-03-17T20:46:37.293923Z","steps":["trace[948518540] 'read index received' (duration: 2.215842566s)","trace[948518540] 'applied index is now lower than readState.Index' (duration: 40.561µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:37.304426Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.604824206s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:37.304567Z","caller":"traceutil/trace.go:172","msg":"trace[1776098307] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:536; }","duration":"2.60498679s","start":"2026-03-17T20:46:34.699560Z","end":"2026-03-17T20:46:37.304546Z","steps":["trace[1776098307] 'agreement among raft nodes before linearized reading' (duration: 2.59456723s)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:37.306072Z","caller":"traceutil/trace.go:172","msg":"trace[516559734] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"2.587239787s","start":"2026-03-17T20:46:34.718815Z","end":"2026-03-17T20:46:37.306055Z","steps":["trace[516559734] 'process raft request' (duration: 2.575303842s)","trace[516559734] 'compare' (duration: 11.736961ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:37.306312Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:34.718801Z","time spent":"2.587342789s","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T20:46:37.940447Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.506788159s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:37.940533Z","caller":"traceutil/trace.go:172","msg":"trace[810473496] range","detail":"{range_begin:/registry/controllers; range_end:; response_count:0; response_revision:537; }","duration":"1.506884771s","start":"2026-03-17T20:46:36.433626Z","end":"2026-03-17T20:46:37.940510Z","steps":["trace[810473496] 'agreement among raft nodes before linearized reading' (duration: 901.819242ms)","trace[810473496] 'range keys from in-memory index tree' (duration: 604.947727ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:37.940582Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:36.433586Z","time spent":"1.506984223s","remote":"127.0.0.1:48070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":28,"request content":"key:\"/registry/controllers\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:46:37.940606Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.222593302s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-17T20:46:37.940649Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.871066131s","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-03-17T20:46:37.940650Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.204499443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:37.940696Z","caller":"traceutil/trace.go:172","msg":"trace[184009623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"1.222690984s","start":"2026-03-17T20:46:36.717982Z","end":"2026-03-17T20:46:37.940673Z","steps":["trace[184009623] 'agreement among raft nodes before linearized reading' (duration: 617.44437ms)","trace[184009623] 'range keys from in-memory index tree' (duration: 605.119361ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:37.940725Z","caller":"traceutil/trace.go:172","msg":"trace[866981484] range","detail":"{range_begin:/registry/services/specs; range_end:; response_count:0; response_revision:537; }","duration":"1.871153733s","start":"2026-03-17T20:46:36.069552Z","end":"2026-03-17T20:46:37.940706Z","steps":["trace[866981484] 'agreement among raft nodes before linearized reading' (duration: 1.265914239s)","trace[866981484] 'range keys from in-memory index tree' (duration: 605.127111ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:37.940734Z","caller":"traceutil/trace.go:172","msg":"trace[1982263902] range","detail":"{range_begin:/registry/volumeattachments; range_end:; response_count:0; response_revision:537; }","duration":"1.204609106s","start":"2026-03-17T20:46:36.736106Z","end":"2026-03-17T20:46:37.940715Z","steps":["trace[1982263902] 'agreement among raft nodes before linearized reading' (duration: 599.304441ms)","trace[1982263902] 'range keys from in-memory index tree' (duration: 605.166322ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:37.940739Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:36.717955Z","time spent":"1.222775296s","remote":"127.0.0.1:47722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-17T20:46:37.940768Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:36.069520Z","time spent":"1.871237704s","remote":"127.0.0.1:48034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:46:37.940773Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:36.736093Z","time spent":"1.204671277s","remote":"127.0.0.1:48478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:46:37.940834Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.501889325s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:59 size:4985"} {"level":"info","ts":"2026-03-17T20:46:37.940886Z","caller":"traceutil/trace.go:172","msg":"trace[1815266451] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:59; response_revision:537; }","duration":"1.501955966s","start":"2026-03-17T20:46:36.438917Z","end":"2026-03-17T20:46:37.940873Z","steps":["trace[1815266451] 'agreement among raft nodes before linearized reading' (duration: 896.518958ms)","trace[1815266451] 'range keys from in-memory index tree' (duration: 605.150452ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:37.940956Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:36.438887Z","time spent":"1.502061909s","remote":"127.0.0.1:48736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":59,"response size":5008,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true "} {"level":"warn","ts":"2026-03-17T20:46:37.940953Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.854953247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattributesclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:37.940981Z","caller":"traceutil/trace.go:172","msg":"trace[200603687] range","detail":"{range_begin:/registry/volumeattributesclasses; range_end:; response_count:0; response_revision:537; }","duration":"1.854977808s","start":"2026-03-17T20:46:36.085993Z","end":"2026-03-17T20:46:37.940971Z","steps":["trace[200603687] 'agreement among raft nodes before linearized reading' (duration: 1.249460437s)","trace[200603687] 'range keys from in-memory index tree' (duration: 605.47812ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:37.941002Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:36.085966Z","time spent":"1.855029019s","remote":"127.0.0.1:48510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattributesclasses\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:46:37.941101Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.54925237s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:37.941153Z","caller":"traceutil/trace.go:172","msg":"trace[895734283] range","detail":"{range_begin:/registry/csinodes; range_end:; response_count:0; response_revision:537; }","duration":"2.549290051s","start":"2026-03-17T20:46:35.391835Z","end":"2026-03-17T20:46:37.941125Z","steps":["trace[895734283] 'agreement among raft nodes before linearized reading' (duration: 1.943638917s)","trace[895734283] 'range keys from in-memory index tree' (duration: 605.601523ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:37.941162Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"605.850388ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-03-17T20:46:37.941406Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"790.139048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:37.941465Z","caller":"traceutil/trace.go:172","msg":"trace[98470042] range","detail":"{range_begin:/registry/priorityclasses; range_end:; response_count:0; response_revision:537; }","duration":"790.193369ms","start":"2026-03-17T20:46:37.151257Z","end":"2026-03-17T20:46:37.941450Z","steps":["trace[98470042] 'agreement among raft nodes before linearized reading' (duration: 184.101446ms)","trace[98470042] 'range keys from in-memory index tree' (duration: 606.006872ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:37.941496Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:37.151226Z","time spent":"790.261571ms","remote":"127.0.0.1:48438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses\" limit:1 "} {"level":"warn","ts":"2026-03-17T20:46:37.941184Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:35.391806Z","time spent":"2.549369903s","remote":"127.0.0.1:48514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":22,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes\" limit:1 "} {"level":"info","ts":"2026-03-17T20:46:37.942025Z","caller":"traceutil/trace.go:172","msg":"trace[274701808] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:560; }","duration":"606.728568ms","start":"2026-03-17T20:46:37.335280Z","end":"2026-03-17T20:46:37.942009Z","steps":["trace[274701808] 'read index received' (duration: 202.774µs)","trace[274701808] 'applied index is now lower than readState.Index' (duration: 606.523764ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:37.942138Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"636.139188ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:37.942206Z","caller":"traceutil/trace.go:172","msg":"trace[1086856818] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:538; }","duration":"636.211229ms","start":"2026-03-17T20:46:37.305985Z","end":"2026-03-17T20:46:37.942196Z","steps":["trace[1086856818] 'agreement among raft nodes before linearized reading' (duration: 636.118127ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:37.942435Z","caller":"traceutil/trace.go:172","msg":"trace[1826811308] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.944068353s","start":"2026-03-17T20:46:35.998355Z","end":"2026-03-17T20:46:37.942423Z","steps":["trace[1826811308] 'process raft request' (duration: 1.942872955s)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:37.942537Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:35.998321Z","time spent":"1.944151205s","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:38.414901Z","caller":"traceutil/trace.go:172","msg":"trace[1121820160] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:563; }","duration":"131.009993ms","start":"2026-03-17T20:46:38.283760Z","end":"2026-03-17T20:46:38.414770Z","steps":["trace[1121820160] 'read index received' (duration: 131.000133ms)","trace[1121820160] 'applied index is now lower than readState.Index' (duration: 8.62µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:38.494580Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"210.793632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:38.494664Z","caller":"traceutil/trace.go:172","msg":"trace[1233065415] range","detail":"{range_begin:/registry/persistentvolumes; range_end:; response_count:0; response_revision:539; }","duration":"210.902845ms","start":"2026-03-17T20:46:38.283740Z","end":"2026-03-17T20:46:38.494643Z","steps":["trace[1233065415] 'agreement among raft nodes before linearized reading' (duration: 131.176156ms)","trace[1233065415] 'range keys from in-memory index tree' (duration: 79.563645ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:38.494817Z","caller":"traceutil/trace.go:172","msg":"trace[1225988972] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"511.616412ms","start":"2026-03-17T20:46:37.983176Z","end":"2026-03-17T20:46:38.494792Z","steps":["trace[1225988972] 'process raft request' (duration: 431.829592ms)","trace[1225988972] 'compare' (duration: 79.422942ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:38.494925Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:37.983152Z","time spent":"511.718945ms","remote":"127.0.0.1:47818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":747,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:46:38.773658Z","caller":"traceutil/trace.go:172","msg":"trace[713258266] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"781.199882ms","start":"2026-03-17T20:46:37.992441Z","end":"2026-03-17T20:46:38.773641Z","steps":["trace[713258266] 'process raft request' (duration: 698.081184ms)","trace[713258266] 'compare' (duration: 82.625297ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:38.773872Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:37.992411Z","time spent":"781.394276ms","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18605,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:39.527954Z","caller":"traceutil/trace.go:172","msg":"trace[845870022] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:567; }","duration":"119.129762ms","start":"2026-03-17T20:46:39.408797Z","end":"2026-03-17T20:46:39.527927Z","steps":["trace[845870022] 'read index received' (duration: 119.121612ms)","trace[845870022] 'applied index is now lower than readState.Index' (duration: 6.76µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:39.560361Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"170.421833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-17T20:46:39.560508Z","caller":"traceutil/trace.go:172","msg":"trace[512619591] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:1; response_revision:543; }","duration":"170.569686ms","start":"2026-03-17T20:46:39.389886Z","end":"2026-03-17T20:46:39.560456Z","steps":["trace[512619591] 'agreement among raft nodes before linearized reading' (duration: 138.16061ms)","trace[512619591] 'range keys from in-memory index tree' (duration: 32.078059ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:40.809446Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.092758ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:40.809757Z","caller":"traceutil/trace.go:172","msg":"trace[785952359] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:550; }","duration":"110.418066ms","start":"2026-03-17T20:46:40.699323Z","end":"2026-03-17T20:46:40.809741Z","steps":["trace[785952359] 'range keys from in-memory index tree' (duration: 110.036187ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:41.831051Z","caller":"traceutil/trace.go:172","msg":"trace[568858400] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:578; }","duration":"116.299805ms","start":"2026-03-17T20:46:41.714726Z","end":"2026-03-17T20:46:41.831026Z","steps":["trace[568858400] 'read index received' (duration: 116.290104ms)","trace[568858400] 'applied index is now lower than readState.Index' (duration: 8.701µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:41.831208Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.463098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:41.831238Z","caller":"traceutil/trace.go:172","msg":"trace[1955784723] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"116.513759ms","start":"2026-03-17T20:46:41.714716Z","end":"2026-03-17T20:46:41.831230Z","steps":["trace[1955784723] 'agreement among raft nodes before linearized reading' (duration: 116.422117ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:41.831282Z","caller":"traceutil/trace.go:172","msg":"trace[1451942145] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"450.473623ms","start":"2026-03-17T20:46:41.380783Z","end":"2026-03-17T20:46:41.831257Z","steps":["trace[1451942145] 'process raft request' (duration: 450.33552ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:41.831435Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:41.380748Z","time spent":"450.618716ms","remote":"127.0.0.1:47818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":747,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:46:41.963048Z","caller":"traceutil/trace.go:172","msg":"trace[981880380] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:579; }","duration":"131.900712ms","start":"2026-03-17T20:46:41.831114Z","end":"2026-03-17T20:46:41.963015Z","steps":["trace[981880380] 'read index received' (duration: 131.889842ms)","trace[981880380] 'applied index is now lower than readState.Index' (duration: 9.36µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:41.980216Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"207.456274ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:41.980309Z","caller":"traceutil/trace.go:172","msg":"trace[2122265886] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:553; }","duration":"207.572087ms","start":"2026-03-17T20:46:41.772716Z","end":"2026-03-17T20:46:41.980288Z","steps":["trace[2122265886] 'agreement among raft nodes before linearized reading' (duration: 190.392413ms)","trace[2122265886] 'range keys from in-memory index tree' (duration: 17.035971ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:41.980856Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"148.758809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:41.981393Z","caller":"traceutil/trace.go:172","msg":"trace[199282273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"149.308131ms","start":"2026-03-17T20:46:41.832064Z","end":"2026-03-17T20:46:41.981372Z","steps":["trace[199282273] 'agreement among raft nodes before linearized reading' (duration: 148.726768ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:41.981139Z","caller":"traceutil/trace.go:172","msg":"trace[1617829365] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"573.154564ms","start":"2026-03-17T20:46:41.407939Z","end":"2026-03-17T20:46:41.981094Z","steps":["trace[1617829365] 'process raft request' (duration: 555.159261ms)","trace[1617829365] 'compare' (duration: 17.479571ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:41.982086Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:41.407904Z","time spent":"574.069965ms","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:42.211643Z","caller":"traceutil/trace.go:172","msg":"trace[1433839128] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:581; }","duration":"127.485795ms","start":"2026-03-17T20:46:42.084115Z","end":"2026-03-17T20:46:42.211601Z","steps":["trace[1433839128] 'read index received' (duration: 127.475565ms)","trace[1433839128] 'applied index is now lower than readState.Index' (duration: 8.49µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:42.212555Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"128.443427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:42.212686Z","caller":"traceutil/trace.go:172","msg":"trace[1571943909] range","detail":"{range_begin:/registry/prioritylevelconfigurations; range_end:; response_count:0; response_revision:555; }","duration":"128.59467ms","start":"2026-03-17T20:46:42.084073Z","end":"2026-03-17T20:46:42.212668Z","steps":["trace[1571943909] 'agreement among raft nodes before linearized reading' (duration: 127.678319ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:42.212974Z","caller":"traceutil/trace.go:172","msg":"trace[104065923] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"188.684644ms","start":"2026-03-17T20:46:42.024258Z","end":"2026-03-17T20:46:42.212942Z","steps":["trace[104065923] 'process raft request' (duration: 187.415996ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:42.226409Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.03678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:42.226476Z","caller":"traceutil/trace.go:172","msg":"trace[898899635] range","detail":"{range_begin:/registry/rolebindings; range_end:; response_count:0; response_revision:556; }","duration":"101.127882ms","start":"2026-03-17T20:46:42.125336Z","end":"2026-03-17T20:46:42.226464Z","steps":["trace[898899635] 'agreement among raft nodes before linearized reading' (duration: 100.981959ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:47.139046Z","caller":"traceutil/trace.go:172","msg":"trace[143635527] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"352.799193ms","start":"2026-03-17T20:46:46.786224Z","end":"2026-03-17T20:46:47.139023Z","steps":["trace[143635527] 'process raft request' (duration: 352.624719ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:47.139197Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:46.786207Z","time spent":"352.920226ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:46:47.163351Z","caller":"traceutil/trace.go:172","msg":"trace[675784375] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"195.071366ms","start":"2026-03-17T20:46:46.968251Z","end":"2026-03-17T20:46:47.163322Z","steps":["trace[675784375] 'process raft request' (duration: 194.198846ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:47.458524Z","caller":"traceutil/trace.go:172","msg":"trace[43159425] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:619; }","duration":"221.061983ms","start":"2026-03-17T20:46:47.237434Z","end":"2026-03-17T20:46:47.458496Z","steps":["trace[43159425] 'read index received' (duration: 221.053002ms)","trace[43159425] 'applied index is now lower than readState.Index' (duration: 7.461µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:47.458677Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"221.216446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:47.458703Z","caller":"traceutil/trace.go:172","msg":"trace[590407667] range","detail":"{range_begin:/registry/certificatesigningrequests; range_end:; response_count:0; response_revision:592; }","duration":"221.269107ms","start":"2026-03-17T20:46:47.237427Z","end":"2026-03-17T20:46:47.458696Z","steps":["trace[590407667] 'agreement among raft nodes before linearized reading' (duration: 221.164345ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:47.458885Z","caller":"traceutil/trace.go:172","msg":"trace[1804087977] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"283.68858ms","start":"2026-03-17T20:46:47.175172Z","end":"2026-03-17T20:46:47.458861Z","steps":["trace[1804087977] 'process raft request' (duration: 283.601488ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:47.458906Z","caller":"traceutil/trace.go:172","msg":"trace[827304406] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"285.326477ms","start":"2026-03-17T20:46:47.173535Z","end":"2026-03-17T20:46:47.458861Z","steps":["trace[827304406] 'process raft request' (duration: 285.048911ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:47.734133Z","caller":"traceutil/trace.go:172","msg":"trace[164658366] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:621; }","duration":"166.408145ms","start":"2026-03-17T20:46:47.567688Z","end":"2026-03-17T20:46:47.734097Z","steps":["trace[164658366] 'read index received' (duration: 166.395555ms)","trace[164658366] 'applied index is now lower than readState.Index' (duration: 10.9µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:47.756761Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"189.028777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:47.756899Z","caller":"traceutil/trace.go:172","msg":"trace[1566795700] range","detail":"{range_begin:/registry/namespaces; range_end:; response_count:0; response_revision:594; }","duration":"189.17925ms","start":"2026-03-17T20:46:47.567682Z","end":"2026-03-17T20:46:47.756861Z","steps":["trace[1566795700] 'agreement among raft nodes before linearized reading' (duration: 166.539248ms)","trace[1566795700] 'range keys from in-memory index tree' (duration: 22.413528ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:47.757623Z","caller":"traceutil/trace.go:172","msg":"trace[1266652497] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"545.039704ms","start":"2026-03-17T20:46:47.212555Z","end":"2026-03-17T20:46:47.757595Z","steps":["trace[1266652497] 'process raft request' (duration: 521.720086ms)","trace[1266652497] 'compare' (duration: 22.229203ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:47.757812Z","caller":"traceutil/trace.go:172","msg":"trace[2046939045] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"543.51876ms","start":"2026-03-17T20:46:47.214273Z","end":"2026-03-17T20:46:47.757791Z","steps":["trace[2046939045] 'process raft request' (duration: 543.311065ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:47.757839Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.212524Z","time spent":"545.229519ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4165,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:47.757833Z","caller":"traceutil/trace.go:172","msg":"trace[2009452604] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"344.627228ms","start":"2026-03-17T20:46:47.413190Z","end":"2026-03-17T20:46:47.757817Z","steps":["trace[2009452604] 'process raft request' (duration: 344.572907ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:47.757935Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.214244Z","time spent":"543.609201ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9296,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:47.757943Z","caller":"traceutil/trace.go:172","msg":"trace[1968435374] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"389.846722ms","start":"2026-03-17T20:46:47.368012Z","end":"2026-03-17T20:46:47.757859Z","steps":["trace[1968435374] 'process raft request' (duration: 389.711319ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:47.758144Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.367962Z","time spent":"390.093488ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:46:47.758298Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.413144Z","time spent":"344.831413ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:47.826537Z","caller":"traceutil/trace.go:172","msg":"trace[141206304] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"258.09016ms","start":"2026-03-17T20:46:47.568424Z","end":"2026-03-17T20:46:47.826515Z","steps":["trace[141206304] 'process raft request' (duration: 258.053549ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:47.826663Z","caller":"traceutil/trace.go:172","msg":"trace[1698119717] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"358.077812ms","start":"2026-03-17T20:46:47.468561Z","end":"2026-03-17T20:46:47.826638Z","steps":["trace[1698119717] 'process raft request' (duration: 357.770985ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:47.826735Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.468544Z","time spent":"358.133953ms","remote":"127.0.0.1:48834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":932,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:46:47.826960Z","caller":"traceutil/trace.go:172","msg":"trace[593998522] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"352.977449ms","start":"2026-03-17T20:46:47.473962Z","end":"2026-03-17T20:46:47.826940Z","steps":["trace[593998522] 'process raft request' (duration: 352.484957ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:47.827058Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.473940Z","time spent":"353.063951ms","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4135,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:47.827179Z","caller":"traceutil/trace.go:172","msg":"trace[1536216728] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"354.053713ms","start":"2026-03-17T20:46:47.473116Z","end":"2026-03-17T20:46:47.827169Z","steps":["trace[1536216728] 'process raft request' (duration: 353.298975ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:47.827156Z","caller":"traceutil/trace.go:172","msg":"trace[1320811861] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"354.41857ms","start":"2026-03-17T20:46:47.472689Z","end":"2026-03-17T20:46:47.827107Z","steps":["trace[1320811861] 'process raft request' (duration: 353.680893ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:47.826542Z","caller":"traceutil/trace.go:172","msg":"trace[1079200361] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"361.139672ms","start":"2026-03-17T20:46:47.465379Z","end":"2026-03-17T20:46:47.826519Z","steps":["trace[1079200361] 'process raft request' (duration: 360.815795ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:47.827456Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.472678Z","time spent":"354.596405ms","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4365,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T20:46:47.827478Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.465348Z","time spent":"362.004813ms","remote":"127.0.0.1:47818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:46:47.827226Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.473101Z","time spent":"354.100223ms","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4365,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:48.178497Z","caller":"traceutil/trace.go:172","msg":"trace[1130513880] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"411.797852ms","start":"2026-03-17T20:46:47.766672Z","end":"2026-03-17T20:46:48.178470Z","steps":["trace[1130513880] 'process raft request' (duration: 375.706646ms)","trace[1130513880] 'compare' (duration: 35.398ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:48.178933Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.766637Z","time spent":"412.237201ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:46:48.178548Z","caller":"traceutil/trace.go:172","msg":"trace[1628425526] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"402.564623ms","start":"2026-03-17T20:46:47.775962Z","end":"2026-03-17T20:46:48.178527Z","steps":["trace[1628425526] 'process raft request' (duration: 402.512912ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:48.179301Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.775946Z","time spent":"403.238227ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:48.178746Z","caller":"traceutil/trace.go:172","msg":"trace[1245599761] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"410.304377ms","start":"2026-03-17T20:46:47.768281Z","end":"2026-03-17T20:46:48.178586Z","steps":["trace[1245599761] 'process raft request' (duration: 410.122153ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:48.179542Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.768270Z","time spent":"411.181676ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:48.540334Z","caller":"traceutil/trace.go:172","msg":"trace[1063846721] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:634; }","duration":"396.831292ms","start":"2026-03-17T20:46:48.143473Z","end":"2026-03-17T20:46:48.540304Z","steps":["trace[1063846721] 'read index received' (duration: 396.819792ms)","trace[1063846721] 'applied index is now lower than readState.Index' (duration: 9.22µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:48.550799Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"407.3057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:48.550871Z","caller":"traceutil/trace.go:172","msg":"trace[576645391] range","detail":"{range_begin:/registry/podtemplates; range_end:; response_count:0; response_revision:607; }","duration":"407.396402ms","start":"2026-03-17T20:46:48.143457Z","end":"2026-03-17T20:46:48.550853Z","steps":["trace[576645391] 'agreement among raft nodes before linearized reading' (duration: 396.973496ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:48.550945Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:48.143417Z","time spent":"407.519864ms","remote":"127.0.0.1:47918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates\" limit:1 "} {"level":"info","ts":"2026-03-17T20:46:48.551316Z","caller":"traceutil/trace.go:172","msg":"trace[1741611001] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"717.331978ms","start":"2026-03-17T20:46:47.833940Z","end":"2026-03-17T20:46:48.551272Z","steps":["trace[1741611001] 'process raft request' (duration: 706.482883ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:48.551362Z","caller":"traceutil/trace.go:172","msg":"trace[263889748] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"584.045631ms","start":"2026-03-17T20:46:47.967285Z","end":"2026-03-17T20:46:48.551331Z","steps":["trace[263889748] 'process raft request' (duration: 583.917988ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:48.551402Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.833911Z","time spent":"717.4321ms","remote":"127.0.0.1:47818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-17T20:46:48.551322Z","caller":"traceutil/trace.go:172","msg":"trace[599443613] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"470.765102ms","start":"2026-03-17T20:46:48.080541Z","end":"2026-03-17T20:46:48.551307Z","steps":["trace[599443613] 'process raft request' (duration: 470.723411ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:48.552802Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:48.080463Z","time spent":"472.230195ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T20:46:48.551979Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:47.967254Z","time spent":"584.186365ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:46:48.596482Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"431.930655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-17T20:46:48.596534Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"133.600876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-66bc5c9577-df9rl\" limit:1 ","response":"range_response_count:1 size:4150"} {"level":"info","ts":"2026-03-17T20:46:48.596618Z","caller":"traceutil/trace.go:172","msg":"trace[530390237] range","detail":"{range_begin:/registry/pods/kube-system/coredns-66bc5c9577-df9rl; range_end:; response_count:1; response_revision:610; }","duration":"133.700958ms","start":"2026-03-17T20:46:48.462894Z","end":"2026-03-17T20:46:48.596595Z","steps":["trace[530390237] 'agreement among raft nodes before linearized reading' (duration: 133.441722ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:48.596689Z","caller":"traceutil/trace.go:172","msg":"trace[105486751] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"430.264597ms","start":"2026-03-17T20:46:48.166394Z","end":"2026-03-17T20:46:48.596659Z","steps":["trace[105486751] 'process raft request' (duration: 430.025631ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:48.596777Z","caller":"traceutil/trace.go:172","msg":"trace[181603049] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"409.383466ms","start":"2026-03-17T20:46:48.187381Z","end":"2026-03-17T20:46:48.596765Z","steps":["trace[181603049] 'process raft request' (duration: 409.158841ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:48.596777Z","caller":"traceutil/trace.go:172","msg":"trace[934770898] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"227.276043ms","start":"2026-03-17T20:46:48.369489Z","end":"2026-03-17T20:46:48.596765Z","steps":["trace[934770898] 'process raft request' (duration: 227.248442ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:48.596837Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:48.166357Z","time spent":"430.40771ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-17T20:46:48.596865Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:48.187361Z","time spent":"409.447607ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:48.596953Z","caller":"traceutil/trace.go:172","msg":"trace[1954300620] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"401.961787ms","start":"2026-03-17T20:46:48.194986Z","end":"2026-03-17T20:46:48.596948Z","steps":["trace[1954300620] 'process raft request' (duration: 401.62891ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:48.596981Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:48.194958Z","time spent":"402.007868ms","remote":"127.0.0.1:47794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T20:46:48.597046Z","caller":"traceutil/trace.go:172","msg":"trace[520854413] range","detail":"{range_begin:/registry/ingress; range_end:; response_count:0; response_revision:610; }","duration":"432.059948ms","start":"2026-03-17T20:46:48.164512Z","end":"2026-03-17T20:46:48.596571Z","steps":["trace[520854413] 'agreement among raft nodes before linearized reading' (duration: 431.867683ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:48.597067Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-17T20:46:48.164485Z","time spent":"432.576949ms","remote":"127.0.0.1:48234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":28,"request content":"key:\"/registry/ingress\" limit:1 "} {"level":"info","ts":"2026-03-17T20:46:48.733294Z","caller":"traceutil/trace.go:172","msg":"trace[985802749] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:642; }","duration":"105.248047ms","start":"2026-03-17T20:46:48.627981Z","end":"2026-03-17T20:46:48.733229Z","steps":["trace[985802749] 'read index received' (duration: 105.221787ms)","trace[985802749] 'applied index is now lower than readState.Index' (duration: 24.32µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:48.775969Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"147.88545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" limit:1 ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-03-17T20:46:48.776101Z","caller":"traceutil/trace.go:172","msg":"trace[374135046] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:615; }","duration":"148.087924ms","start":"2026-03-17T20:46:48.627968Z","end":"2026-03-17T20:46:48.776056Z","steps":["trace[374135046] 'agreement among raft nodes before linearized reading' (duration: 105.39305ms)","trace[374135046] 'range keys from in-memory index tree' (duration: 42.268684ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:48.776268Z","caller":"traceutil/trace.go:172","msg":"trace[566218817] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"171.287408ms","start":"2026-03-17T20:46:48.604952Z","end":"2026-03-17T20:46:48.776240Z","steps":["trace[566218817] 'process raft request' (duration: 128.304618ms)","trace[566218817] 'compare' (duration: 42.51691ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:48.776615Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"108.99068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-5l2kk.189dbbe1c8d4738c\" limit:1 ","response":"range_response_count:1 size:799"} {"level":"info","ts":"2026-03-17T20:46:48.776655Z","caller":"traceutil/trace.go:172","msg":"trace[1309663863] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"169.484168ms","start":"2026-03-17T20:46:48.607162Z","end":"2026-03-17T20:46:48.776647Z","steps":["trace[1309663863] 'process raft request' (duration: 168.950466ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:48.776660Z","caller":"traceutil/trace.go:172","msg":"trace[1300353469] range","detail":"{range_begin:/registry/events/kube-system/cilium-5l2kk.189dbbe1c8d4738c; range_end:; response_count:1; response_revision:618; }","duration":"109.050812ms","start":"2026-03-17T20:46:48.667598Z","end":"2026-03-17T20:46:48.776649Z","steps":["trace[1300353469] 'agreement among raft nodes before linearized reading' (duration: 108.899968ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:48.776616Z","caller":"traceutil/trace.go:172","msg":"trace[720019305] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"170.378967ms","start":"2026-03-17T20:46:48.606223Z","end":"2026-03-17T20:46:48.776602Z","steps":["trace[720019305] 'process raft request' (duration: 169.829415ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:49.006200Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"129.433593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T20:46:49.006337Z","caller":"traceutil/trace.go:172","msg":"trace[684606134] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"179.573205ms","start":"2026-03-17T20:46:48.826741Z","end":"2026-03-17T20:46:49.006314Z","steps":["trace[684606134] 'process raft request' (duration: 49.942788ms)","trace[684606134] 'compare' (duration: 129.256619ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:49.006685Z","caller":"traceutil/trace.go:172","msg":"trace[1040276283] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"129.339532ms","start":"2026-03-17T20:46:48.877323Z","end":"2026-03-17T20:46:49.006662Z","steps":["trace[1040276283] 'process raft request' (duration: 129.226849ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:49.074601Z","caller":"traceutil/trace.go:172","msg":"trace[338057541] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"195.208096ms","start":"2026-03-17T20:46:48.879370Z","end":"2026-03-17T20:46:49.074578Z","steps":["trace[338057541] 'process raft request' (duration: 195.063892ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:49.310490Z","caller":"traceutil/trace.go:172","msg":"trace[1611608863] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"172.898497ms","start":"2026-03-17T20:46:49.137566Z","end":"2026-03-17T20:46:49.310464Z","steps":["trace[1611608863] 'process raft request' (duration: 110.254096ms)","trace[1611608863] 'compare' (duration: 62.237082ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:49.643697Z","caller":"traceutil/trace.go:172","msg":"trace[854764779] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"122.310928ms","start":"2026-03-17T20:46:49.521349Z","end":"2026-03-17T20:46:49.643660Z","steps":["trace[854764779] 'process raft request' (duration: 122.099073ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:50.203420Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35260","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:46:51.562835Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35270","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:46:51.577310Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35284","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:46:51.684136Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35306","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:46:51.713242Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35324","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:46:51.868828Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35336","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:46:52.801949Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"102.67101ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:52.802018Z","caller":"traceutil/trace.go:172","msg":"trace[1282514477] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:653; }","duration":"102.764272ms","start":"2026-03-17T20:46:52.699240Z","end":"2026-03-17T20:46:52.802004Z","steps":["trace[1282514477] 'range keys from in-memory index tree' (duration: 102.612429ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:52.802609Z","caller":"traceutil/trace.go:172","msg":"trace[829261542] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:681; }","duration":"122.425814ms","start":"2026-03-17T20:46:52.680162Z","end":"2026-03-17T20:46:52.802588Z","steps":["trace[829261542] 'read index received' (duration: 122.408014ms)","trace[829261542] 'applied index is now lower than readState.Index' (duration: 16.37µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:52.802910Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"129.720428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deviceclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:52.803052Z","caller":"traceutil/trace.go:172","msg":"trace[415512648] range","detail":"{range_begin:/registry/deviceclasses; range_end:; response_count:0; response_revision:653; }","duration":"129.886342ms","start":"2026-03-17T20:46:52.673147Z","end":"2026-03-17T20:46:52.803033Z","steps":["trace[415512648] 'agreement among raft nodes before linearized reading' (duration: 129.669917ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:52.803341Z","caller":"traceutil/trace.go:172","msg":"trace[1108368892] transaction","detail":"{read_only:false; number_of_response:0; response_revision:653; }","duration":"139.500296ms","start":"2026-03-17T20:46:52.663820Z","end":"2026-03-17T20:46:52.803320Z","steps":["trace[1108368892] 'process raft request' (duration: 139.365493ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:52.806830Z","caller":"traceutil/trace.go:172","msg":"trace[1013101942] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"124.099271ms","start":"2026-03-17T20:46:52.682714Z","end":"2026-03-17T20:46:52.806813Z","steps":["trace[1013101942] 'process raft request' (duration: 123.822765ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:53.337924Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35366","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:46:55.168286Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"155.836163ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-17T20:46:55.168537Z","caller":"traceutil/trace.go:172","msg":"trace[1040277282] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:700; }","duration":"134.683491ms","start":"2026-03-17T20:46:55.033805Z","end":"2026-03-17T20:46:55.168488Z","steps":["trace[1040277282] 'read index received' (duration: 64.591µs)","trace[1040277282] 'applied index is now lower than readState.Index' (duration: 134.61683ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T20:46:55.169374Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"135.551422ms","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-03-17T20:46:55.169457Z","caller":"traceutil/trace.go:172","msg":"trace[1320160886] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:671; }","duration":"135.638434ms","start":"2026-03-17T20:46:55.033788Z","end":"2026-03-17T20:46:55.169426Z","steps":["trace[1320160886] 'agreement among raft nodes before linearized reading' (duration: 134.808735ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:46:55.909928Z","caller":"traceutil/trace.go:172","msg":"trace[2059668859] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:702; }","duration":"108.287154ms","start":"2026-03-17T20:46:55.801594Z","end":"2026-03-17T20:46:55.909881Z","steps":["trace[2059668859] 'read index received' (duration: 108.273364ms)","trace[2059668859] 'applied index is now lower than readState.Index' (duration: 12.3µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:46:55.910072Z","caller":"traceutil/trace.go:172","msg":"trace[1566040594] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"123.007902ms","start":"2026-03-17T20:46:55.787041Z","end":"2026-03-17T20:46:55.910048Z","steps":["trace[1566040594] 'process raft request' (duration: 122.859579ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:46:55.910151Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"108.531449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:46:55.910202Z","caller":"traceutil/trace.go:172","msg":"trace[1446167019] range","detail":"{range_begin:/registry/statefulsets; range_end:; response_count:0; response_revision:673; }","duration":"108.607941ms","start":"2026-03-17T20:46:55.801580Z","end":"2026-03-17T20:46:55.910188Z","steps":["trace[1446167019] 'agreement among raft nodes before linearized reading' (duration: 108.461528ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:47:16.705132Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54770","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:47:16.736640Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54794","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:47:16.745253Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54818","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-17T20:47:16.758792Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54844","server-name":"","error":"EOF"} {"level":"info","ts":"2026-03-17T20:47:27.055099Z","caller":"traceutil/trace.go:172","msg":"trace[1625881651] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"138.01732ms","start":"2026-03-17T20:47:26.916823Z","end":"2026-03-17T20:47:27.054841Z","steps":["trace[1625881651] 'process raft request' (duration: 137.874147ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:47:43.808733Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.119275ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T20:47:43.808922Z","caller":"traceutil/trace.go:172","msg":"trace[447887973] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:771; }","duration":"109.325149ms","start":"2026-03-17T20:47:43.699583Z","end":"2026-03-17T20:47:43.808909Z","steps":["trace[447887973] 'range keys from in-memory index tree' (duration: 109.070984ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T20:47:45.766941Z","caller":"traceutil/trace.go:172","msg":"trace[1780384763] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:813; }","duration":"122.727935ms","start":"2026-03-17T20:47:45.644192Z","end":"2026-03-17T20:47:45.766919Z","steps":["trace[1780384763] 'read index received' (duration: 122.722065ms)","trace[1780384763] 'applied index is now lower than readState.Index' (duration: 4.79µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T20:47:45.767451Z","caller":"traceutil/trace.go:172","msg":"trace[1079556567] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"158.312869ms","start":"2026-03-17T20:47:45.609119Z","end":"2026-03-17T20:47:45.767431Z","steps":["trace[1079556567] 'process raft request' (duration: 158.082274ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:47:45.767484Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.071062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver\" limit:1 ","response":"range_response_count:1 size:679"} {"level":"info","ts":"2026-03-17T20:47:45.767835Z","caller":"traceutil/trace.go:172","msg":"trace[1787054212] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver; range_end:; response_count:1; response_revision:774; }","duration":"101.432021ms","start":"2026-03-17T20:47:45.666388Z","end":"2026-03-17T20:47:45.767820Z","steps":["trace[1787054212] 'agreement among raft nodes before linearized reading' (duration: 100.996221ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T20:47:45.767731Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"123.527073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:kubelet-serving-approver\" limit:1 ","response":"range_response_count:1 size:682"} {"level":"info","ts":"2026-03-17T20:47:45.768007Z","caller":"traceutil/trace.go:172","msg":"trace[286079942] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:kubelet-serving-approver; range_end:; response_count:1; response_revision:773; }","duration":"123.805638ms","start":"2026-03-17T20:47:45.644187Z","end":"2026-03-17T20:47:45.767992Z","steps":["trace[286079942] 'agreement among raft nodes before linearized reading' (duration: 122.880138ms)"],"step_count":1}