{"level":"warn","ts":"2026-05-20T20:58:30.580408Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-05-20T20:58:30.580672Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-05-20T20:58:30.580748Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.204.45.250:2380","--initial-cluster=controller=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250:2380","--name=controller","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-05-20T20:58:30.580953Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-05-20T20:58:30.580985Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T20:58:30.581035Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-05-20T20:58:30.581071Z","caller":"embed/etcd.go:544","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T20:58:30.582320Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-05-20T20:58:30.582788Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.204.45.250:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"feature-gates":"InitialCorruptCheck=true","initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","discovery-token":"","discovery-endpoints":"","discovery-dial-timeout":"2s","discovery-request-timeout":"5s","discovery-keepalive-time":"2s","discovery-keepalive-timeout":"6s","discovery-insecure-transport":true,"discovery-insecure-skip-tls-verify":false,"discovery-cert":"","discovery-key":"","discovery-cacert":"","discovery-user":"","downgrade-check-interval":"5s","max-learners":1,"v2-deprecation":"write-only"} {"level":"info","ts":"2026-05-20T20:58:30.585068Z","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: 0xc000122230}"} {"level":"info","ts":"2026-05-20T20:58:30.643571Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-05-20T20:58:30.644172Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"60.476542ms"} {"level":"info","ts":"2026-05-20T20:58:30.644296Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-05-20T20:58:30.644316Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-05-20T20:58:30.644366Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-05-20T20:58:31.334102Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-05-20T20:58:31.334263Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-05-20T20:58:31.334316Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-05-20T20:58:31.334422Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T20:58:31.334500Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-05-20T20:58:31.334513Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T20:58:31.334529Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-05-20T20:58:31.334587Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-05-20T20:58:31.343818Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T20:58:31.362667Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T20:58:31.377269Z","caller":"storage/quota.go:93","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-20T20:58:31.378028Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T20:58:31.378294Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T20:58:31.378517Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T20:58:31.378630Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T20:58:31.378650Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T20:58:31.378853Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-05-20T20:58:31.379093Z","caller":"embed/etcd.go:766","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T20:58:31.379186Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-05-20T20:58:31.379183Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-05-20T20:58:31.379280Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-05-20T20:58:31.379897Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T20:58:31.379977Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T20:58:31.835710Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T20:58:31.835776Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T20:58:31.835865Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-05-20T20:58:31.835883Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"d98d5f2c752cc52d has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-20T20:58:31.835933Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-05-20T20:58:31.888096Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-05-20T20:58:31.888208Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"d98d5f2c752cc52d has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-20T20:58:31.888243Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-05-20T20:58:31.888260Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-05-20T20:58:31.891918Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T20:58:31.891930Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T20:58:31.891986Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T20:58:31.891899Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:controller ClientURLs:[https://199.204.45.250:2379]}","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T20:58:31.892668Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T20:58:31.892754Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T20:58:31.894889Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-05-20T20:58:31.895572Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.6"} {"level":"warn","ts":"2026-05-20T20:58:31.895637Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-05-20T20:58:31.896015Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T20:58:31.896042Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-05-20T20:58:31.896138Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T20:58:31.896311Z","caller":"version/monitor.go:116","msg":"cluster version differs from storage version.","cluster-version":"3.6.0","storage-version":"3.5.0"} {"level":"info","ts":"2026-05-20T20:58:31.896481Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-05-20T20:58:31.899945Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-05-20T20:58:31.901214Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-20T20:58:31.901542Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50294","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:31.901668Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50310","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:31.909479Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50332","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:31.910704Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50364","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:31.930646Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50408","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:31.947523Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50438","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:31.958423Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50478","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:31.969038Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50488","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:31.979134Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50502","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:31.990378Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50526","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:31.997744Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50534","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.008120Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50554","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.020676Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50580","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.027733Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50590","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.037127Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50602","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.048420Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50620","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.062646Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50640","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.076656Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50656","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.080634Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50674","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.090054Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50686","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.100368Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50708","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.112954Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50738","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.166020Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50760","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.175950Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50776","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.186940Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50794","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.195396Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50818","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.206878Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50838","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.216743Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50850","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.229871Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50866","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.242448Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50872","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.249881Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50876","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.258223Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.266781Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50900","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.279756Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50928","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.288756Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50948","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.296590Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50958","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.307260Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50972","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.315426Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50980","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.329920Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51006","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.337517Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51032","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.345438Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51048","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.355793Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51076","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.363710Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51104","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.373180Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51126","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.382257Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51140","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.392131Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51162","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.414332Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51164","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.425884Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51178","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.434498Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51200","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.441398Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51216","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.449490Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51238","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.458278Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51252","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.467139Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51266","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.476425Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51300","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.486491Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51304","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.496239Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51322","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.505245Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51334","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.512519Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51350","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.534985Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51358","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.544922Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51374","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.553713Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51390","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:58:32.600849Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51406","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-20T20:58:33.372382Z","caller":"traceutil/trace.go:172","msg":"trace[841315544] linearizableReadLoop","detail":"{readStateIndex:52; appliedIndex:52; }","duration":"101.331369ms","start":"2026-05-20T20:58:33.271014Z","end":"2026-05-20T20:58:33.372345Z","steps":["trace[841315544] 'read index received' (duration: 101.322598ms)","trace[841315544] 'applied index is now lower than readState.Index' (duration: 6.891µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:58:33.561762Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"290.7282ms","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-05-20T20:58:33.561881Z","caller":"traceutil/trace.go:172","msg":"trace[2107868639] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-ho7paesrdksqaoi6iuwwu33dmq; range_end:; response_count:0; response_revision:48; }","duration":"290.862982ms","start":"2026-05-20T20:58:33.270996Z","end":"2026-05-20T20:58:33.561859Z","steps":["trace[2107868639] 'agreement among raft nodes before linearized reading' (duration: 101.45942ms)","trace[2107868639] 'range keys from in-memory index tree' (duration: 189.23564ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:58:33.563572Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"189.448722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"warn","ts":"2026-05-20T20:58:33.564185Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"221.056218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/controller\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T20:58:33.564260Z","caller":"traceutil/trace.go:172","msg":"trace[39325570] range","detail":"{range_begin:/registry/csinodes/controller; range_end:; response_count:0; response_revision:49; }","duration":"221.148559ms","start":"2026-05-20T20:58:33.343100Z","end":"2026-05-20T20:58:33.564248Z","steps":["trace[39325570] 'agreement among raft nodes before linearized reading' (duration: 221.003227ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:33.564120Z","caller":"traceutil/trace.go:172","msg":"trace[1484740373] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"426.892805ms","start":"2026-05-20T20:58:33.137034Z","end":"2026-05-20T20:58:33.563927Z","steps":["trace[1484740373] 'process raft request' (duration: 235.408295ms)","trace[1484740373] 'compare' (duration: 189.290071ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:58:33.564068Z","caller":"traceutil/trace.go:172","msg":"trace[1788651153] linearizableReadLoop","detail":"{readStateIndex:53; appliedIndex:52; }","duration":"191.558031ms","start":"2026-05-20T20:58:33.372474Z","end":"2026-05-20T20:58:33.564032Z","steps":["trace[1788651153] 'read index received' (duration: 31.487943ms)","trace[1788651153] 'applied index is now lower than readState.Index' (duration: 160.067348ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:58:33.564889Z","caller":"traceutil/trace.go:172","msg":"trace[98142382] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"427.154008ms","start":"2026-05-20T20:58:33.137454Z","end":"2026-05-20T20:58:33.564608Z","steps":["trace[98142382] 'process raft request' (duration: 426.562081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:33.564591Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:33.137024Z","time spent":"427.533623ms","remote":"127.0.0.1:51152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":661,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:58:33.565452Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:33.137439Z","time spent":"427.735196ms","remote":"127.0.0.1:51152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1201,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:58:33.565076Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:33.143285Z","time spent":"421.755058ms","remote":"127.0.0.1:50464","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-20T20:58:33.707786Z","caller":"traceutil/trace.go:172","msg":"trace[1684707017] linearizableReadLoop","detail":"{readStateIndex:55; appliedIndex:55; }","duration":"139.495208ms","start":"2026-05-20T20:58:33.568272Z","end":"2026-05-20T20:58:33.707768Z","steps":["trace[1684707017] 'read index received' (duration: 139.489098ms)","trace[1684707017] 'applied index is now lower than readState.Index' (duration: 4.87µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:58:33.711323Z","caller":"traceutil/trace.go:172","msg":"trace[303883830] transaction","detail":"{read_only:false; number_of_response:0; response_revision:50; }","duration":"160.391773ms","start":"2026-05-20T20:58:33.550918Z","end":"2026-05-20T20:58:33.711309Z","steps":["trace[303883830] 'process raft request' (duration: 157.178691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:33.711419Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"143.178746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/controller\" limit:1 ","response":"range_response_count:1 size:3218"} {"level":"info","ts":"2026-05-20T20:58:33.711692Z","caller":"traceutil/trace.go:172","msg":"trace[85482927] range","detail":"{range_begin:/registry/minions/controller; range_end:; response_count:1; response_revision:50; }","duration":"143.241277ms","start":"2026-05-20T20:58:33.568220Z","end":"2026-05-20T20:58:33.711461Z","steps":["trace[85482927] 'agreement among raft nodes before linearized reading' (duration: 139.758272ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:33.715391Z","caller":"traceutil/trace.go:172","msg":"trace[1217801549] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"145.242584ms","start":"2026-05-20T20:58:33.570135Z","end":"2026-05-20T20:58:33.715378Z","steps":["trace[1217801549] 'process raft request' (duration: 145.190093ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:33.715536Z","caller":"traceutil/trace.go:172","msg":"trace[834362456] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"148.264823ms","start":"2026-05-20T20:58:33.567259Z","end":"2026-05-20T20:58:33.715524Z","steps":["trace[834362456] 'process raft request' (duration: 147.963109ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:33.715640Z","caller":"traceutil/trace.go:172","msg":"trace[1226709176] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"146.390589ms","start":"2026-05-20T20:58:33.569225Z","end":"2026-05-20T20:58:33.715616Z","steps":["trace[1226709176] 'process raft request' (duration: 146.069795ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:33.716008Z","caller":"traceutil/trace.go:172","msg":"trace[1144152352] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"150.180528ms","start":"2026-05-20T20:58:33.565812Z","end":"2026-05-20T20:58:33.715993Z","steps":["trace[1144152352] 'process raft request' (duration: 149.221696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:38.129812Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"168.443557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" limit:1 ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-20T20:58:38.129931Z","caller":"traceutil/trace.go:172","msg":"trace[730343700] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:318; }","duration":"168.576389ms","start":"2026-05-20T20:58:37.961332Z","end":"2026-05-20T20:58:38.129908Z","steps":["trace[730343700] 'agreement among raft nodes before linearized reading' (duration: 84.349133ms)","trace[730343700] 'range keys from in-memory index tree' (duration: 84.036764ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:58:38.129982Z","caller":"traceutil/trace.go:172","msg":"trace[824244120] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"200.560235ms","start":"2026-05-20T20:58:37.929393Z","end":"2026-05-20T20:58:38.129953Z","steps":["trace[824244120] 'process raft request' (duration: 116.342869ms)","trace[824244120] 'compare' (duration: 84.069604ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:58:38.381893Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"120.179103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-20T20:58:38.381969Z","caller":"traceutil/trace.go:172","msg":"trace[1961603376] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:320; }","duration":"120.266124ms","start":"2026-05-20T20:58:38.261688Z","end":"2026-05-20T20:58:38.381954Z","steps":["trace[1961603376] 'range keys from in-memory index tree' (duration: 120.047511ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:38.583875Z","caller":"traceutil/trace.go:172","msg":"trace[1821338398] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"197.621909ms","start":"2026-05-20T20:58:38.385707Z","end":"2026-05-20T20:58:38.583329Z","steps":["trace[1821338398] 'process raft request' (duration: 197.501517ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:38.763760Z","caller":"traceutil/trace.go:172","msg":"trace[756609396] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"172.932019ms","start":"2026-05-20T20:58:38.590812Z","end":"2026-05-20T20:58:38.763744Z","steps":["trace[756609396] 'process raft request' (duration: 152.097139ms)","trace[756609396] 'compare' (duration: 20.729118ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:58:41.761097Z","caller":"traceutil/trace.go:172","msg":"trace[1280565734] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"248.229316ms","start":"2026-05-20T20:58:41.512843Z","end":"2026-05-20T20:58:41.761072Z","steps":["trace[1280565734] 'process raft request' (duration: 246.233444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:42.451186Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"280.028725ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:58:42.451296Z","caller":"traceutil/trace.go:172","msg":"trace[130542224] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"488.521073ms","start":"2026-05-20T20:58:41.962758Z","end":"2026-05-20T20:58:42.451279Z","steps":["trace[130542224] 'process raft request' (duration: 208.339145ms)","trace[130542224] 'compare' (duration: 279.454096ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:58:42.451371Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:41.962723Z","time spent":"488.604755ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:58:42.690437Z","caller":"traceutil/trace.go:172","msg":"trace[710569188] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"230.230855ms","start":"2026-05-20T20:58:42.460177Z","end":"2026-05-20T20:58:42.690408Z","steps":["trace[710569188] 'process raft request' (duration: 224.979129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:43.243046Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174616,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T20:58:43.329315Z","caller":"traceutil/trace.go:172","msg":"trace[135699140] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:365; }","duration":"587.045805ms","start":"2026-05-20T20:58:42.742237Z","end":"2026-05-20T20:58:43.329283Z","steps":["trace[135699140] 'read index received' (duration: 587.037515ms)","trace[135699140] 'applied index is now lower than readState.Index' (duration: 6.67µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:58:43.329560Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"587.290348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 ","response":"range_response_count:1 size:238"} {"level":"info","ts":"2026-05-20T20:58:43.329539Z","caller":"traceutil/trace.go:172","msg":"trace[1200090140] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"598.47287ms","start":"2026-05-20T20:58:42.731038Z","end":"2026-05-20T20:58:43.329511Z","steps":["trace[1200090140] 'process raft request' (duration: 598.332958ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:43.329610Z","caller":"traceutil/trace.go:172","msg":"trace[323966664] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner; range_end:; response_count:1; response_revision:349; }","duration":"587.368821ms","start":"2026-05-20T20:58:42.742231Z","end":"2026-05-20T20:58:43.329600Z","steps":["trace[323966664] 'agreement among raft nodes before linearized reading' (duration: 587.180067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:43.329646Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.742215Z","time spent":"587.420471ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":262,"request content":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:43.329706Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.731028Z","time spent":"598.596563ms","remote":"127.0.0.1:50666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4017,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:58:43.829459Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174619,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T20:58:44.015494Z","caller":"traceutil/trace.go:172","msg":"trace[237307309] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:366; }","duration":"686.076776ms","start":"2026-05-20T20:58:43.329383Z","end":"2026-05-20T20:58:44.015459Z","steps":["trace[237307309] 'read index received' (duration: 686.062256ms)","trace[237307309] 'applied index is now lower than readState.Index' (duration: 12.83µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:58:44.015675Z","caller":"traceutil/trace.go:172","msg":"trace[1744854941] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"1.284604509s","start":"2026-05-20T20:58:42.731050Z","end":"2026-05-20T20:58:44.015655Z","steps":["trace[1744854941] 'process raft request' (duration: 1.284470665s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.015763Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.249333255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-20T20:58:44.015737Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.203813054s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-20T20:58:44.015813Z","caller":"traceutil/trace.go:172","msg":"trace[762977388] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:350; }","duration":"1.249400286s","start":"2026-05-20T20:58:42.766397Z","end":"2026-05-20T20:58:44.015798Z","steps":["trace[762977388] 'agreement among raft nodes before linearized reading' (duration: 1.249199312s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.015817Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.248827006s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-05-20T20:58:44.015831Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.731036Z","time spent":"1.2847277s","remote":"127.0.0.1:51230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3924,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:58:44.016089Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.251370837s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-05-20T20:58:44.015945Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.153930522s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-20T20:58:44.016137Z","caller":"traceutil/trace.go:172","msg":"trace[1818529260] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:351; }","duration":"1.251418158s","start":"2026-05-20T20:58:42.764705Z","end":"2026-05-20T20:58:44.016123Z","steps":["trace[1818529260] 'agreement among raft nodes before linearized reading' (duration: 1.251292326s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.016170Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.764689Z","time spent":"1.25147078s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:58:44.015839Z","caller":"traceutil/trace.go:172","msg":"trace[317300079] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:350; }","duration":"1.203938076s","start":"2026-05-20T20:58:42.811881Z","end":"2026-05-20T20:58:44.015819Z","steps":["trace[317300079] 'agreement among raft nodes before linearized reading' (duration: 1.203687561s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.016234Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.811868Z","time spent":"1.204355703s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":221,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.015851Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.766389Z","time spent":"1.249453577s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:58:44.015875Z","caller":"traceutil/trace.go:172","msg":"trace[2090838041] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:350; }","duration":"1.248945858s","start":"2026-05-20T20:58:42.766914Z","end":"2026-05-20T20:58:44.015860Z","steps":["trace[2090838041] 'agreement among raft nodes before linearized reading' (duration: 1.248623572s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.016403Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.766908Z","time spent":"1.249475876s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:58:44.016143Z","caller":"traceutil/trace.go:172","msg":"trace[1469012849] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:351; }","duration":"1.154126295s","start":"2026-05-20T20:58:42.862004Z","end":"2026-05-20T20:58:44.016131Z","steps":["trace[1469012849] 'agreement among raft nodes before linearized reading' (duration: 1.153868521s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.015939Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.259208785s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-20T20:58:44.016567Z","caller":"traceutil/trace.go:172","msg":"trace[756148124] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:351; }","duration":"1.259827285s","start":"2026-05-20T20:58:42.756723Z","end":"2026-05-20T20:58:44.016551Z","steps":["trace[756148124] 'agreement among raft nodes before linearized reading' (duration: 1.259160534s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.015967Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.255047537s","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":"info","ts":"2026-05-20T20:58:44.016695Z","caller":"traceutil/trace.go:172","msg":"trace[1851872185] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:351; }","duration":"1.25577452s","start":"2026-05-20T20:58:42.760904Z","end":"2026-05-20T20:58:44.016679Z","steps":["trace[1851872185] 'agreement among raft nodes before linearized reading' (duration: 1.254963337s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.016754Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.760895Z","time spent":"1.255842761s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.015990Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.227420738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-20T20:58:44.016835Z","caller":"traceutil/trace.go:172","msg":"trace[39058125] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:351; }","duration":"1.228262961s","start":"2026-05-20T20:58:42.788555Z","end":"2026-05-20T20:58:44.016818Z","steps":["trace[39058125] 'agreement among raft nodes before linearized reading' (duration: 1.227350767s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.016042Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.247434604s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-05-20T20:58:44.016882Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.788542Z","time spent":"1.228326812s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":258,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:58:44.016917Z","caller":"traceutil/trace.go:172","msg":"trace[1511472006] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-cidrs-controller; range_end:; response_count:1; response_revision:351; }","duration":"1.248304488s","start":"2026-05-20T20:58:42.768599Z","end":"2026-05-20T20:58:44.016903Z","steps":["trace[1511472006] 'agreement among raft nodes before linearized reading' (duration: 1.247379333s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.016053Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.266391443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-05-20T20:58:44.016964Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.768586Z","time spent":"1.248365359s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:58:44.016981Z","caller":"traceutil/trace.go:172","msg":"trace[1366259658] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:351; }","duration":"1.267320918s","start":"2026-05-20T20:58:42.749645Z","end":"2026-05-20T20:58:44.016966Z","steps":["trace[1366259658] 'agreement among raft nodes before linearized reading' (duration: 1.26624123s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.017032Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.749632Z","time spent":"1.267386089s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.016929Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.756710Z","time spent":"1.259955238s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":227,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.016758Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:42.861991Z","time spent":"1.154469791s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":242,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:58:44.508431Z","caller":"traceutil/trace.go:172","msg":"trace[850465482] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:367; }","duration":"492.834375ms","start":"2026-05-20T20:58:44.015566Z","end":"2026-05-20T20:58:44.508400Z","steps":["trace[850465482] 'read index received' (duration: 492.822055ms)","trace[850465482] 'applied index is now lower than readState.Index' (duration: 10.64µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:58:44.918264Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.584415269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 ","response":"range_response_count:1 size:238"} {"level":"info","ts":"2026-05-20T20:58:44.918356Z","caller":"traceutil/trace.go:172","msg":"trace[1264183450] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner; range_end:; response_count:1; response_revision:351; }","duration":"1.584523211s","start":"2026-05-20T20:58:43.333813Z","end":"2026-05-20T20:58:44.918336Z","steps":["trace[1264183450] 'agreement among raft nodes before linearized reading' (duration: 1.174721371s)","trace[1264183450] 'range keys from in-memory index tree' (duration: 409.473915ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:58:44.918401Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:43.333785Z","time spent":"1.584603332s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":262,"request content":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.918716Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"410.033084ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:58:44.919097Z","caller":"traceutil/trace.go:172","msg":"trace[808257317] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"1.571284443s","start":"2026-05-20T20:58:43.347717Z","end":"2026-05-20T20:58:44.919001Z","steps":["trace[808257317] 'process raft request' (duration: 1.16075002s)","trace[808257317] 'compare' (duration: 409.722659ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:58:44.919274Z","caller":"traceutil/trace.go:172","msg":"trace[1217802787] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"1.42228992s","start":"2026-05-20T20:58:43.496963Z","end":"2026-05-20T20:58:44.919253Z","steps":["trace[1217802787] 'process raft request' (duration: 1.421946995s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.919403Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:43.347688Z","time spent":"1.571517927s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:58:44.919417Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:43.496937Z","time spent":"1.422410552s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:58:44.919425Z","caller":"traceutil/trace.go:172","msg":"trace[742023351] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"1.114463063s","start":"2026-05-20T20:58:43.804931Z","end":"2026-05-20T20:58:44.919394Z","steps":["trace[742023351] 'process raft request' (duration: 1.114151568s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.919633Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:43.804892Z","time spent":"1.114612266s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:58:44.919673Z","caller":"traceutil/trace.go:172","msg":"trace[867125513] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:367; }","duration":"411.139002ms","start":"2026-05-20T20:58:44.508504Z","end":"2026-05-20T20:58:44.919643Z","steps":["trace[867125513] 'read index received' (duration: 407.289516ms)","trace[867125513] 'applied index is now lower than readState.Index' (duration: 3.846716ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:58:44.919770Z","caller":"traceutil/trace.go:172","msg":"trace[1448944789] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"896.037704ms","start":"2026-05-20T20:58:44.023711Z","end":"2026-05-20T20:58:44.919749Z","steps":["trace[1448944789] 'process raft request' (duration: 895.471004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.919864Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.023688Z","time spent":"896.139725ms","remote":"127.0.0.1:50464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:58:44.919860Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"894.67265ms","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-05-20T20:58:44.919905Z","caller":"traceutil/trace.go:172","msg":"trace[1808920708] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:355; }","duration":"894.721021ms","start":"2026-05-20T20:58:44.025174Z","end":"2026-05-20T20:58:44.919895Z","steps":["trace[1808920708] 'agreement among raft nodes before linearized reading' (duration: 894.524728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.919920Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"894.433555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-05-20T20:58:44.919935Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.025163Z","time spent":"894.763991ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:58:44.919954Z","caller":"traceutil/trace.go:172","msg":"trace[350611776] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:355; }","duration":"894.467346ms","start":"2026-05-20T20:58:44.025477Z","end":"2026-05-20T20:58:44.919944Z","steps":["trace[350611776] 'agreement among raft nodes before linearized reading' (duration: 894.278703ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.919981Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.025469Z","time spent":"894.505836ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.920033Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"894.861594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-20T20:58:44.920085Z","caller":"traceutil/trace.go:172","msg":"trace[866312452] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:355; }","duration":"894.925925ms","start":"2026-05-20T20:58:44.025143Z","end":"2026-05-20T20:58:44.920069Z","steps":["trace[866312452] 'agreement among raft nodes before linearized reading' (duration: 894.743812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.920112Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"709.753202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:58:44.920131Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.025129Z","time spent":"894.991086ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":242,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:58:44.920137Z","caller":"traceutil/trace.go:172","msg":"trace[780006122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:355; }","duration":"709.776494ms","start":"2026-05-20T20:58:44.210352Z","end":"2026-05-20T20:58:44.920129Z","steps":["trace[780006122] 'agreement among raft nodes before linearized reading' (duration: 709.708082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.920163Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.210330Z","time spent":"709.828664ms","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T20:58:44.920171Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"894.881714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-20T20:58:44.920201Z","caller":"traceutil/trace.go:172","msg":"trace[83524553] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:355; }","duration":"894.911595ms","start":"2026-05-20T20:58:44.025281Z","end":"2026-05-20T20:58:44.920193Z","steps":["trace[83524553] 'agreement among raft nodes before linearized reading' (duration: 894.825902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.920224Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.025267Z","time spent":"894.951066ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":221,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.920226Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"894.102421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-20T20:58:44.920276Z","caller":"traceutil/trace.go:172","msg":"trace[303361388] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:355; }","duration":"894.152382ms","start":"2026-05-20T20:58:44.026112Z","end":"2026-05-20T20:58:44.920264Z","steps":["trace[303361388] 'agreement among raft nodes before linearized reading' (duration: 894.03466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.920309Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.026104Z","time spent":"894.197702ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":227,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.920346Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"895.156299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-20T20:58:44.920370Z","caller":"traceutil/trace.go:172","msg":"trace[1257214799] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:355; }","duration":"895.179399ms","start":"2026-05-20T20:58:44.025183Z","end":"2026-05-20T20:58:44.920363Z","steps":["trace[1257214799] 'agreement among raft nodes before linearized reading' (duration: 895.110388ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.920377Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"896.725466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-05-20T20:58:44.920391Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.025174Z","time spent":"895.21211ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:58:44.920413Z","caller":"traceutil/trace.go:172","msg":"trace[1294795700] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:355; }","duration":"896.759386ms","start":"2026-05-20T20:58:44.023641Z","end":"2026-05-20T20:58:44.920400Z","steps":["trace[1294795700] 'agreement among raft nodes before linearized reading' (duration: 896.663725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.920439Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.023624Z","time spent":"896.808857ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.920498Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"896.658665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-05-20T20:58:44.920511Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"896.687305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-20T20:58:44.920521Z","caller":"traceutil/trace.go:172","msg":"trace[832277498] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:355; }","duration":"896.680005ms","start":"2026-05-20T20:58:44.023834Z","end":"2026-05-20T20:58:44.920514Z","steps":["trace[832277498] 'agreement among raft nodes before linearized reading' (duration: 896.616454ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:44.920553Z","caller":"traceutil/trace.go:172","msg":"trace[1087550855] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-cidrs-controller; range_end:; response_count:1; response_revision:355; }","duration":"896.730065ms","start":"2026-05-20T20:58:44.023814Z","end":"2026-05-20T20:58:44.920544Z","steps":["trace[1087550855] 'agreement among raft nodes before linearized reading' (duration: 896.632104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.920493Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"899.019733ms","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":"warn","ts":"2026-05-20T20:58:44.920561Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.023823Z","time spent":"896.731126ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.920581Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.023801Z","time spent":"896.772986ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.920550Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"896.837847ms","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":"info","ts":"2026-05-20T20:58:44.920602Z","caller":"traceutil/trace.go:172","msg":"trace[1081798738] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:355; }","duration":"899.127925ms","start":"2026-05-20T20:58:44.021457Z","end":"2026-05-20T20:58:44.920585Z","steps":["trace[1081798738] 'agreement among raft nodes before linearized reading' (duration: 898.913582ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:44.920632Z","caller":"traceutil/trace.go:172","msg":"trace[1659367989] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:355; }","duration":"896.936689ms","start":"2026-05-20T20:58:44.023684Z","end":"2026-05-20T20:58:44.920621Z","steps":["trace[1659367989] 'agreement among raft nodes before linearized reading' (duration: 896.771316ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.920657Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.021440Z","time spent":"899.200057ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":258,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.920668Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.023677Z","time spent":"896.980119ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:44.922022Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"240.941725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-20T20:58:44.922352Z","caller":"traceutil/trace.go:172","msg":"trace[1045608899] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"896.770536ms","start":"2026-05-20T20:58:44.025450Z","end":"2026-05-20T20:58:44.922221Z","steps":["trace[1045608899] 'process raft request' (duration: 894.166971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:44.922644Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:44.025433Z","time spent":"896.953729ms","remote":"127.0.0.1:51176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3973,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:58:44.922949Z","caller":"traceutil/trace.go:172","msg":"trace[2117819736] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:356; }","duration":"240.994056ms","start":"2026-05-20T20:58:44.681066Z","end":"2026-05-20T20:58:44.922060Z","steps":["trace[2117819736] 'agreement among raft nodes before linearized reading' (duration: 240.877624ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:46.733991Z","caller":"traceutil/trace.go:172","msg":"trace[229193632] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"127.74538ms","start":"2026-05-20T20:58:46.606225Z","end":"2026-05-20T20:58:46.733971Z","steps":["trace[229193632] 'process raft request' (duration: 80.791736ms)","trace[229193632] 'compare' (duration: 46.853122ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:58:55.883770Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174742,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:58:56.384791Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174742,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:58:56.455052Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.77246196s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T20:58:56.455396Z","caller":"traceutil/trace.go:172","msg":"trace[1042228545] linearizableReadLoop","detail":"{readStateIndex:441; appliedIndex:441; }","duration":"1.072050329s","start":"2026-05-20T20:58:55.383318Z","end":"2026-05-20T20:58:56.455368Z","steps":["trace[1042228545] 'read index received' (duration: 1.072026579s)","trace[1042228545] 'applied index is now lower than readState.Index' (duration: 21.6µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:58:56.455553Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:54.682462Z","time spent":"1.773087992s","remote":"127.0.0.1:50378","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-20T20:58:56.455637Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.072310925s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" limit:1 ","response":"range_response_count:1 size:4338"} {"level":"info","ts":"2026-05-20T20:58:56.455670Z","caller":"traceutil/trace.go:172","msg":"trace[160289285] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:422; }","duration":"1.072362826s","start":"2026-05-20T20:58:55.383298Z","end":"2026-05-20T20:58:56.455661Z","steps":["trace[160289285] 'agreement among raft nodes before linearized reading' (duration: 1.072198683s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:56.455713Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:55.383269Z","time spent":"1.072435968s","remote":"127.0.0.1:51176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4362,"request content":"key:\"/registry/deployments/kube-system/coredns\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:58:56.955548Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174748,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:58:57.456743Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174748,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:58:57.564933Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000075775s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-20T20:58:57.565027Z","caller":"traceutil/trace.go:172","msg":"trace[942718388] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000179327s","start":"2026-05-20T20:58:55.564828Z","end":"2026-05-20T20:58:57.565008Z","steps":["trace[942718388] 'agreement among raft nodes before linearized reading' (duration: 2.000071325s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:57.565134Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:55.564806Z","time spent":"2.0003175s","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T20:58:57.956981Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174748,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:58:58.382501Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.927178296s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T20:58:58.382971Z","caller":"traceutil/trace.go:172","msg":"trace[891761989] linearizableReadLoop","detail":"{readStateIndex:442; appliedIndex:442; }","duration":"1.927473192s","start":"2026-05-20T20:58:56.455465Z","end":"2026-05-20T20:58:58.382938Z","steps":["trace[891761989] 'read index received' (duration: 1.927451701s)","trace[891761989] 'applied index is now lower than readState.Index' (duration: 19.181µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:58:58.383125Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.725915529s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:58:58.383219Z","caller":"traceutil/trace.go:172","msg":"trace[1711594570] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:422; }","duration":"2.726024911s","start":"2026-05-20T20:58:55.657172Z","end":"2026-05-20T20:58:58.383197Z","steps":["trace[1711594570] 'agreement among raft nodes before linearized reading' (duration: 2.725870938s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:58.383506Z","caller":"traceutil/trace.go:172","msg":"trace[1403490365] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"3.43072497s","start":"2026-05-20T20:58:54.952763Z","end":"2026-05-20T20:58:58.383488Z","steps":["trace[1403490365] 'process raft request' (duration: 3.430402573s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:58.383522Z","caller":"traceutil/trace.go:172","msg":"trace[1798665625] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"3.427224149s","start":"2026-05-20T20:58:54.956277Z","end":"2026-05-20T20:58:58.383501Z","steps":["trace[1798665625] 'process raft request' (duration: 3.427069506s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:58.383626Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:54.952737Z","time spent":"3.430810881s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:58:58.383769Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:54.956251Z","time spent":"3.427326202s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:58:58.384437Z","caller":"traceutil/trace.go:172","msg":"trace[1537316310] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"3.084062933s","start":"2026-05-20T20:58:55.300315Z","end":"2026-05-20T20:58:58.384378Z","steps":["trace[1537316310] 'process raft request' (duration: 3.083075822s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:58.384526Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:55.300290Z","time spent":"3.084192585s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:58:58.431843Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"863.576281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:58:58.432089Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.136198357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:58:58.432278Z","caller":"traceutil/trace.go:172","msg":"trace[1045411233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:425; }","duration":"1.136442402s","start":"2026-05-20T20:58:57.295821Z","end":"2026-05-20T20:58:58.432263Z","steps":["trace[1045411233] 'agreement among raft nodes before linearized reading' (duration: 1.136177366s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:58:58.432333Z","caller":"traceutil/trace.go:172","msg":"trace[2125324790] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"1.975468155s","start":"2026-05-20T20:58:56.456837Z","end":"2026-05-20T20:58:58.432305Z","steps":["trace[2125324790] 'process raft request' (duration: 1.97526025s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:58.432866Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:56.456811Z","time spent":"1.975999146s","remote":"127.0.0.1:50378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:58:58.432195Z","caller":"traceutil/trace.go:172","msg":"trace[283787368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:425; }","duration":"863.935758ms","start":"2026-05-20T20:58:57.568240Z","end":"2026-05-20T20:58:58.432176Z","steps":["trace[283787368] 'agreement among raft nodes before linearized reading' (duration: 863.53075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:58.433009Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:57.568218Z","time spent":"864.771605ms","remote":"127.0.0.1:50322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T20:58:58.433168Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:57.295799Z","time spent":"1.137228429s","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T20:58:58.432391Z","caller":"traceutil/trace.go:172","msg":"trace[1849352757] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"1.957958637s","start":"2026-05-20T20:58:56.474413Z","end":"2026-05-20T20:58:58.432372Z","steps":["trace[1849352757] 'process raft request' (duration: 1.957810064s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:58.433583Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:56.474404Z","time spent":"1.959105471s","remote":"127.0.0.1:51176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:58:58.432454Z","caller":"traceutil/trace.go:172","msg":"trace[345624672] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"1.348980917s","start":"2026-05-20T20:58:57.083464Z","end":"2026-05-20T20:58:58.432444Z","steps":["trace[345624672] 'process raft request' (duration: 1.348816024s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:58:58.433757Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:58:57.083439Z","time spent":"1.350275505s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":528,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:59:14.755541Z","caller":"traceutil/trace.go:172","msg":"trace[1503441967] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:534; }","duration":"170.612717ms","start":"2026-05-20T20:59:14.584894Z","end":"2026-05-20T20:59:14.755507Z","steps":["trace[1503441967] 'read index received' (duration: 170.602626ms)","trace[1503441967] 'applied index is now lower than readState.Index' (duration: 8.761µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:14.755693Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"170.777072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:14.755825Z","caller":"traceutil/trace.go:172","msg":"trace[644221286] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:509; }","duration":"170.913185ms","start":"2026-05-20T20:59:14.584879Z","end":"2026-05-20T20:59:14.755792Z","steps":["trace[644221286] 'agreement among raft nodes before linearized reading' (duration: 170.72806ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:14.755912Z","caller":"traceutil/trace.go:172","msg":"trace[2093690586] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"178.893791ms","start":"2026-05-20T20:59:14.576986Z","end":"2026-05-20T20:59:14.755880Z","steps":["trace[2093690586] 'process raft request' (duration: 178.569133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:16.069502Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174956,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:16.570214Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174956,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:16.894745Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.6471453s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T20:59:16.894958Z","caller":"traceutil/trace.go:172","msg":"trace[1519150394] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:570; }","duration":"1.326525705s","start":"2026-05-20T20:59:15.568399Z","end":"2026-05-20T20:59:16.894925Z","steps":["trace[1519150394] 'read index received' (duration: 1.326514335s)","trace[1519150394] 'applied index is now lower than readState.Index' (duration: 9.71µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:17.395789Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174971,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:17.895949Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174971,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:18.396616Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174971,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:18.462535Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.894118036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:18.462642Z","caller":"traceutil/trace.go:172","msg":"trace[1251616159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"2.894220868s","start":"2026-05-20T20:59:15.568394Z","end":"2026-05-20T20:59:18.462614Z","steps":["trace[1251616159] 'agreement among raft nodes before linearized reading' (duration: 1.32667528s)","trace[1251616159] 'range keys from in-memory index tree' (duration: 1.567411365s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:18.462694Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:15.568369Z","time spent":"2.894312191s","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T20:59:18.463655Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.56839871s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:59:18.463761Z","caller":"traceutil/trace.go:172","msg":"trace[281722120] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"3.216288289s","start":"2026-05-20T20:59:15.247450Z","end":"2026-05-20T20:59:18.463739Z","steps":["trace[281722120] 'process raft request' (duration: 1.647705374s)","trace[281722120] 'compare' (duration: 1.567675491s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:18.463848Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:15.247430Z","time spent":"3.216371921s","remote":"127.0.0.1:50424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:18.897164Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174971,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:19.295824Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.00040023s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-20T20:59:19.295910Z","caller":"traceutil/trace.go:172","msg":"trace[656488999] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000501403s","start":"2026-05-20T20:59:17.295389Z","end":"2026-05-20T20:59:19.295891Z","steps":["trace[656488999] 'agreement among raft nodes before linearized reading' (duration: 2.00039689s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:19.295966Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:17.295369Z","time spent":"2.000588084s","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/20 20:59:19 WARNING: [core] [Server #6]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-20T20:59:19.398216Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989174971,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:19.498285Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.42943369s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T20:59:19.498564Z","caller":"traceutil/trace.go:172","msg":"trace[1999671246] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:571; }","duration":"2.603486923s","start":"2026-05-20T20:59:16.895038Z","end":"2026-05-20T20:59:19.498525Z","steps":["trace[1999671246] 'read index received' (duration: 2.603478173s)","trace[1999671246] 'applied index is now lower than readState.Index' (duration: 7.35µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:19.569479Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000146135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-20T20:59:19.569637Z","caller":"traceutil/trace.go:172","msg":"trace[1844996117] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00036017s","start":"2026-05-20T20:59:17.569247Z","end":"2026-05-20T20:59:19.569608Z","steps":["trace[1844996117] 'agreement among raft nodes before linearized reading' (duration: 2.000140365s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:19.569701Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:17.569227Z","time spent":"2.000462943s","remote":"127.0.0.1:50322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/20 20:59:19 WARNING: [core] [Server #6]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-20T20:59:19.799660Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"4.142689445s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:19.799740Z","caller":"traceutil/trace.go:172","msg":"trace[724495075] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:543; }","duration":"4.142785498s","start":"2026-05-20T20:59:15.656934Z","end":"2026-05-20T20:59:19.799720Z","steps":["trace[724495075] 'agreement among raft nodes before linearized reading' (duration: 3.841711049s)","trace[724495075] 'range keys from in-memory index tree' (duration: 300.947406ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:19.800189Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"301.326025ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:59:19.800611Z","caller":"traceutil/trace.go:172","msg":"trace[267707029] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"4.494982352s","start":"2026-05-20T20:59:15.305611Z","end":"2026-05-20T20:59:19.800594Z","steps":["trace[267707029] 'process raft request' (duration: 4.494706064s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:19.800711Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:15.305585Z","time spent":"4.495062935s","remote":"127.0.0.1:50424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:59:19.800751Z","caller":"traceutil/trace.go:172","msg":"trace[1343405375] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"501.548879ms","start":"2026-05-20T20:59:19.299183Z","end":"2026-05-20T20:59:19.800732Z","steps":["trace[1343405375] 'process raft request' (duration: 501.499287ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:19.800763Z","caller":"traceutil/trace.go:172","msg":"trace[1481705798] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"3.038907974s","start":"2026-05-20T20:59:16.761798Z","end":"2026-05-20T20:59:19.800706Z","steps":["trace[1481705798] 'process raft request' (duration: 3.03874686s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:19.800460Z","caller":"traceutil/trace.go:172","msg":"trace[1897018241] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"4.550314048s","start":"2026-05-20T20:59:15.250106Z","end":"2026-05-20T20:59:19.800420Z","steps":["trace[1897018241] 'process raft request' (duration: 4.248664104s)","trace[1897018241] 'compare' (duration: 301.12148ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:59:19.800934Z","caller":"traceutil/trace.go:172","msg":"trace[908598921] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:571; }","duration":"302.263159ms","start":"2026-05-20T20:59:19.498620Z","end":"2026-05-20T20:59:19.800883Z","steps":["trace[908598921] 'read index received' (duration: 252.334919ms)","trace[908598921] 'applied index is now lower than readState.Index' (duration: 49.92678ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:19.800842Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:19.299158Z","time spent":"501.648441ms","remote":"127.0.0.1:50464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":768,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:59:19.800846Z","caller":"traceutil/trace.go:172","msg":"trace[198429699] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"826.798027ms","start":"2026-05-20T20:59:18.974026Z","end":"2026-05-20T20:59:19.800825Z","steps":["trace[198429699] 'process raft request' (duration: 826.571401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:19.801290Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:18.973999Z","time spent":"827.199537ms","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:59:19.800900Z","caller":"traceutil/trace.go:172","msg":"trace[561538329] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"3.312965222s","start":"2026-05-20T20:59:16.487923Z","end":"2026-05-20T20:59:19.800888Z","steps":["trace[561538329] 'process raft request' (duration: 3.312562302s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:19.801189Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"225.296531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:59:19.801383Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:15.250047Z","time spent":"4.550928773s","remote":"127.0.0.1:50424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:19.801395Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:16.487895Z","time spent":"3.313465463s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:59:19.800914Z","caller":"traceutil/trace.go:172","msg":"trace[1132495176] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"747.472985ms","start":"2026-05-20T20:59:19.053412Z","end":"2026-05-20T20:59:19.800885Z","steps":["trace[1132495176] 'process raft request' (duration: 747.229638ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:19.801476Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:19.053384Z","time spent":"748.07424ms","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":674,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:19.801037Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:16.761770Z","time spent":"3.039179981s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:59:19.802699Z","caller":"traceutil/trace.go:172","msg":"trace[377720513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"225.516936ms","start":"2026-05-20T20:59:19.575879Z","end":"2026-05-20T20:59:19.801396Z","steps":["trace[377720513] 'agreement among raft nodes before linearized reading' (duration: 225.26116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:22.748688Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"181.520424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:22.748764Z","caller":"traceutil/trace.go:172","msg":"trace[1657579503] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"181.600357ms","start":"2026-05-20T20:59:22.567151Z","end":"2026-05-20T20:59:22.748751Z","steps":["trace[1657579503] 'range keys from in-memory index tree' (duration: 181.424402ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:22.914443Z","caller":"traceutil/trace.go:172","msg":"trace[2066062027] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"119.855313ms","start":"2026-05-20T20:59:22.794565Z","end":"2026-05-20T20:59:22.914421Z","steps":["trace[2066062027] 'process raft request' (duration: 119.441322ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:24.999190Z","caller":"traceutil/trace.go:172","msg":"trace[1170067733] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"126.573602ms","start":"2026-05-20T20:59:24.872594Z","end":"2026-05-20T20:59:24.999168Z","steps":["trace[1170067733] 'process raft request' (duration: 126.103029ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:25.616063Z","caller":"traceutil/trace.go:172","msg":"trace[670397175] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"155.701034ms","start":"2026-05-20T20:59:25.460298Z","end":"2026-05-20T20:59:25.615999Z","steps":["trace[670397175] 'process raft request' (duration: 155.18383ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:25.851883Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"100.951635ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:59:25.852118Z","caller":"traceutil/trace.go:172","msg":"trace[668883959] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"170.954427ms","start":"2026-05-20T20:59:25.681113Z","end":"2026-05-20T20:59:25.852067Z","steps":["trace[668883959] 'process raft request' (duration: 69.760336ms)","trace[668883959] 'compare' (duration: 100.79589ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:59:26.997633Z","caller":"traceutil/trace.go:172","msg":"trace[474206260] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"176.858933ms","start":"2026-05-20T20:59:26.820749Z","end":"2026-05-20T20:59:26.997608Z","steps":["trace[474206260] 'process raft request' (duration: 118.089317ms)","trace[474206260] 'compare' (duration: 58.640363ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:26.997794Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"179.044462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-20T20:59:26.997897Z","caller":"traceutil/trace.go:172","msg":"trace[228849794] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:618; }","duration":"179.246507ms","start":"2026-05-20T20:59:26.818629Z","end":"2026-05-20T20:59:26.997876Z","steps":["trace[228849794] 'range keys from in-memory index tree' (duration: 178.821466ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:27.007877Z","caller":"traceutil/trace.go:172","msg":"trace[1996111917] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"115.756534ms","start":"2026-05-20T20:59:26.892095Z","end":"2026-05-20T20:59:27.007852Z","steps":["trace[1996111917] 'process raft request' (duration: 115.488327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:28.818215Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.250252061s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:28.818366Z","caller":"traceutil/trace.go:172","msg":"trace[1500039842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"1.250418036s","start":"2026-05-20T20:59:27.567930Z","end":"2026-05-20T20:59:28.818348Z","steps":["trace[1500039842] 'agreement among raft nodes before linearized reading' (duration: 72.70704ms)","trace[1500039842] 'range keys from in-memory index tree' (duration: 1.177509681s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:28.818400Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:27.567910Z","time spent":"1.250483307s","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T20:59:28.818630Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.161560463s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:28.818735Z","caller":"traceutil/trace.go:172","msg":"trace[344106008] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:620; }","duration":"1.161708967s","start":"2026-05-20T20:59:27.657008Z","end":"2026-05-20T20:59:28.818717Z","steps":["trace[344106008] 'range keys from in-memory index tree' (duration: 1.161511141s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:28.819220Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.178540649s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:59:28.819305Z","caller":"traceutil/trace.go:172","msg":"trace[596849956] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"1.796830055s","start":"2026-05-20T20:59:27.022460Z","end":"2026-05-20T20:59:28.819290Z","steps":["trace[596849956] 'process raft request' (duration: 618.151673ms)","trace[596849956] 'compare' (duration: 1.178024634s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:28.819353Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:27.022445Z","time spent":"1.796887257s","remote":"127.0.0.1:50682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2738,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:59:29.319304Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175118,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:29.820252Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175118,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:29.981161Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.340696356s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T20:59:29.981465Z","caller":"traceutil/trace.go:172","msg":"trace[1892516088] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:651; }","duration":"1.162641621s","start":"2026-05-20T20:59:28.818794Z","end":"2026-05-20T20:59:29.981436Z","steps":["trace[1892516088] 'read index received' (duration: 1.16262881s)","trace[1892516088] 'applied index is now lower than readState.Index' (duration: 10.791µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:30.482195Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:30.819828Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.99986328s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-20T20:59:30.820191Z","caller":"traceutil/trace.go:172","msg":"trace[323967554] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00026706s","start":"2026-05-20T20:59:28.819904Z","end":"2026-05-20T20:59:30.820171Z","steps":["trace[323967554] 'agreement among raft nodes before linearized reading' (duration: 1.99986098s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:30.820261Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:28.819872Z","time spent":"2.000364663s","remote":"127.0.0.1:50322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/20 20:59:30 WARNING: [core] [Server #6]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-20T20:59:30.982697Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:31.483100Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:31.594977Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.776170778s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:31.595058Z","caller":"traceutil/trace.go:172","msg":"trace[1639906007] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:621; }","duration":"2.776256631s","start":"2026-05-20T20:59:28.818782Z","end":"2026-05-20T20:59:31.595039Z","steps":["trace[1639906007] 'agreement among raft nodes before linearized reading' (duration: 1.162788324s)","trace[1639906007] 'range keys from in-memory index tree' (duration: 1.613360663s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:31.595418Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.613703463s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:59:31.596511Z","caller":"traceutil/trace.go:172","msg":"trace[677572095] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"4.570006385s","start":"2026-05-20T20:59:27.026398Z","end":"2026-05-20T20:59:31.596404Z","steps":["trace[677572095] 'process raft request' (duration: 2.955260694s)","trace[677572095] 'compare' (duration: 1.613612501s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:31.596847Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:27.026352Z","time spent":"4.570367286s","remote":"127.0.0.1:50682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18507,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:31.636227Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.654715468s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T20:59:31.636462Z","caller":"traceutil/trace.go:172","msg":"trace[2003108368] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:652; }","duration":"1.654893534s","start":"2026-05-20T20:59:29.981537Z","end":"2026-05-20T20:59:31.636430Z","steps":["trace[2003108368] 'read index received' (duration: 1.654881173s)","trace[2003108368] 'applied index is now lower than readState.Index' (duration: 10.781µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:59:31.636810Z","caller":"traceutil/trace.go:172","msg":"trace[218927274] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"3.778700664s","start":"2026-05-20T20:59:27.858092Z","end":"2026-05-20T20:59:31.636793Z","steps":["trace[218927274] 'process raft request' (duration: 3.77854933s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:31.636943Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:27.858052Z","time spent":"3.778812298s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:59:31.637218Z","caller":"traceutil/trace.go:172","msg":"trace[1915421618] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"2.814327118s","start":"2026-05-20T20:59:28.822871Z","end":"2026-05-20T20:59:31.637198Z","steps":["trace[1915421618] 'process raft request' (duration: 2.814191654s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:31.637343Z","caller":"traceutil/trace.go:172","msg":"trace[1871384625] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"2.811740909s","start":"2026-05-20T20:59:28.825591Z","end":"2026-05-20T20:59:31.637331Z","steps":["trace[1871384625] 'process raft request' (duration: 2.811586085s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:31.637359Z","caller":"traceutil/trace.go:172","msg":"trace[483438738] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.762909753s","start":"2026-05-20T20:59:29.874440Z","end":"2026-05-20T20:59:31.637349Z","steps":["trace[483438738] 'process raft request' (duration: 1.762837591s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:31.637294Z","caller":"traceutil/trace.go:172","msg":"trace[132921022] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"2.813023904s","start":"2026-05-20T20:59:28.824229Z","end":"2026-05-20T20:59:31.637253Z","steps":["trace[132921022] 'process raft request' (duration: 2.81291854s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:31.637418Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:28.825566Z","time spent":"2.811816221s","remote":"127.0.0.1:50682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3268,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:31.637458Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:29.874414Z","time spent":"1.762979785s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:31.637448Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:28.822848Z","time spent":"2.814465762s","remote":"127.0.0.1:50464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:59:31.637543Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:28.824217Z","time spent":"2.813231579s","remote":"127.0.0.1:50464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":933,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:59:31.637584Z","caller":"traceutil/trace.go:172","msg":"trace[1025284123] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"2.811685867s","start":"2026-05-20T20:59:28.825850Z","end":"2026-05-20T20:59:31.637535Z","steps":["trace[1025284123] 'process raft request' (duration: 2.811380329s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:31.637759Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:28.825803Z","time spent":"2.811861122s","remote":"127.0.0.1:50762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2879,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:59:31.638222Z","caller":"traceutil/trace.go:172","msg":"trace[872361769] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"3.779033585s","start":"2026-05-20T20:59:27.859006Z","end":"2026-05-20T20:59:31.638039Z","steps":["trace[872361769] 'process raft request' (duration: 3.77775257s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:31.638351Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:27.858997Z","time spent":"3.779289021s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:32.329106Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.503030039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:32.329195Z","caller":"traceutil/trace.go:172","msg":"trace[530938644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"1.503128671s","start":"2026-05-20T20:59:30.826045Z","end":"2026-05-20T20:59:32.329174Z","steps":["trace[530938644] 'agreement among raft nodes before linearized reading' (duration: 886.540906ms)","trace[530938644] 'range keys from in-memory index tree' (duration: 616.450592ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:32.329237Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:30.826034Z","time spent":"1.503194713s","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T20:59:32.329314Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"541.930686ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:32.329381Z","caller":"traceutil/trace.go:172","msg":"trace[233157746] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:629; }","duration":"542.006938ms","start":"2026-05-20T20:59:31.787359Z","end":"2026-05-20T20:59:32.329366Z","steps":["trace[233157746] 'range keys from in-memory index tree' (duration: 541.886065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:32.329574Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.506895173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-controller.18b161b07d7c034f\" limit:1 ","response":"range_response_count:1 size:784"} {"level":"info","ts":"2026-05-20T20:59:32.329619Z","caller":"traceutil/trace.go:172","msg":"trace[2134029380] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-controller.18b161b07d7c034f; range_end:; response_count:1; response_revision:629; }","duration":"1.506939004s","start":"2026-05-20T20:59:30.822668Z","end":"2026-05-20T20:59:32.329607Z","steps":["trace[2134029380] 'agreement among raft nodes before linearized reading' (duration: 889.884106ms)","trace[2134029380] 'range keys from in-memory index tree' (duration: 616.911075ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:32.329647Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:30.822646Z","time spent":"1.506993176s","remote":"127.0.0.1:50464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":808,"request content":"key:\"/registry/events/kube-system/kube-apiserver-controller.18b161b07d7c034f\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:32.329697Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"733.270806ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:32.329839Z","caller":"traceutil/trace.go:172","msg":"trace[115289798] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:629; }","duration":"733.40599ms","start":"2026-05-20T20:59:31.596415Z","end":"2026-05-20T20:59:32.329821Z","steps":["trace[115289798] 'agreement among raft nodes before linearized reading' (duration: 116.160436ms)","trace[115289798] 'range keys from in-memory index tree' (duration: 617.088999ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:32.330057Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"617.355616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:59:32.330311Z","caller":"traceutil/trace.go:172","msg":"trace[615498932] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"2.265578344s","start":"2026-05-20T20:59:30.064707Z","end":"2026-05-20T20:59:32.330285Z","steps":["trace[615498932] 'process raft request' (duration: 1.647939519s)","trace[615498932] 'compare' (duration: 616.573265ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:32.330400Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:30.064680Z","time spent":"2.265673276s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":674,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:32.832477Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175130,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:33.332666Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175130,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:33.833253Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175130,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:34.331739Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.999517481s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-20T20:59:34.331817Z","caller":"traceutil/trace.go:172","msg":"trace[1404217518] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999605313s","start":"2026-05-20T20:59:32.332195Z","end":"2026-05-20T20:59:34.331801Z","steps":["trace[1404217518] 'agreement among raft nodes before linearized reading' (duration: 1.999514831s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:34.331882Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:32.332178Z","time spent":"1.999695505s","remote":"127.0.0.1:50322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/20 20:59:34 WARNING: [core] [Server #6]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-20T20:59:34.333969Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175130,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:34.834376Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175130,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:35.335428Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175130,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:35.836282Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175130,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:36.336914Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175130,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T20:59:36.339884Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.999521642s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-20T20:59:36.339972Z","caller":"traceutil/trace.go:172","msg":"trace[1907751636] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999641765s","start":"2026-05-20T20:59:34.340310Z","end":"2026-05-20T20:59:36.339952Z","steps":["trace[1907751636] 'agreement among raft nodes before linearized reading' (duration: 1.999519422s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:36.340061Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:34.340281Z","time spent":"1.999748998s","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/20 20:59:36 WARNING: [core] [Server #6]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-20T20:59:36.692107Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.174642393s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-20T20:59:37.800374Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"5.47019448s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-05-20T20:59:37.800672Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"5.469405949s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.800731Z","caller":"traceutil/trace.go:172","msg":"trace[569382769] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:630; }","duration":"5.469475851s","start":"2026-05-20T20:59:32.331243Z","end":"2026-05-20T20:59:37.800719Z","steps":["trace[569382769] 'range keys from in-memory index tree' (duration: 5.469362758s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:37.800748Z","caller":"traceutil/trace.go:172","msg":"trace[297848557] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"5.468527184s","start":"2026-05-20T20:59:32.332200Z","end":"2026-05-20T20:59:37.800727Z","steps":["trace[297848557] 'read index received' (duration: 4.36018638s)","trace[297848557] 'applied index is now lower than readState.Index' (duration: 1.108339494s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:37.801566Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:37.339633Z","time spent":"461.928303ms","remote":"127.0.0.1:44542","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-20T20:59:37.802006Z","caller":"traceutil/trace.go:172","msg":"trace[2134495447] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"5.4701586s","start":"2026-05-20T20:59:32.331819Z","end":"2026-05-20T20:59:37.801978Z","steps":["trace[2134495447] 'process raft request' (duration: 5.468705009s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.802680Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:32.331798Z","time spent":"5.470428618s","remote":"127.0.0.1:50464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":769,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:37.854841Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.162430534s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-20T20:59:37.859310Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.450579848s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.859379Z","caller":"traceutil/trace.go:172","msg":"trace[1065003526] range","detail":"{range_begin:/registry/replicasets; range_end:; response_count:0; response_revision:631; }","duration":"2.450662321s","start":"2026-05-20T20:59:35.408702Z","end":"2026-05-20T20:59:37.859364Z","steps":["trace[1065003526] 'agreement among raft nodes before linearized reading' (duration: 2.446425221s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.859423Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:35.408680Z","time spent":"2.450735363s","remote":"127.0.0.1:51230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":29,"request content":"key:\"/registry/replicasets\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:37.859452Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.17489755s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-20T20:59:37.859531Z","caller":"traceutil/trace.go:172","msg":"trace[1287004680] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:631; }","duration":"3.174961031s","start":"2026-05-20T20:59:34.684546Z","end":"2026-05-20T20:59:37.859507Z","steps":["trace[1287004680] 'agreement among raft nodes before linearized reading' (duration: 3.170591577s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.859602Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:34.684525Z","time spent":"3.175062774s","remote":"127.0.0.1:50378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.250\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:37.859816Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"884.657733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.859848Z","caller":"traceutil/trace.go:172","msg":"trace[1707919674] range","detail":"{range_begin:/registry/flowschemas; range_end:; response_count:0; response_revision:631; }","duration":"884.691084ms","start":"2026-05-20T20:59:36.975150Z","end":"2026-05-20T20:59:37.859841Z","steps":["trace[1707919674] 'agreement among raft nodes before linearized reading' (duration: 879.97536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.859871Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:36.975138Z","time spent":"884.726314ms","remote":"127.0.0.1:51152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":29,"request content":"key:\"/registry/flowschemas\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:37.859953Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"755.336307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deviceclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:59:37.859310Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.69736641s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.860029Z","caller":"traceutil/trace.go:172","msg":"trace[309650831] range","detail":"{range_begin:/registry/deviceclasses; range_end:; response_count:0; response_revision:631; }","duration":"755.425169ms","start":"2026-05-20T20:59:37.104586Z","end":"2026-05-20T20:59:37.860011Z","steps":["trace[309650831] 'agreement among raft nodes before linearized reading' (duration: 750.52578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.860069Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:37.104568Z","time spent":"755.494202ms","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":27,"response count":0,"response size":29,"request content":"key:\"/registry/deviceclasses\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:37.860389Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"5.002827571s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:59:37.860385Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"910.619743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:62 size:5264"} {"level":"info","ts":"2026-05-20T20:59:37.860416Z","caller":"traceutil/trace.go:172","msg":"trace[1659401978] range","detail":"{range_begin:/registry/ingress; range_end:; response_count:0; response_revision:631; }","duration":"5.002858841s","start":"2026-05-20T20:59:32.857551Z","end":"2026-05-20T20:59:37.860410Z","steps":["trace[1659401978] 'agreement among raft nodes before linearized reading' (duration: 4.997615493s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.860421Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"273.375937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:59:37.860434Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:32.857523Z","time spent":"5.002906612s","remote":"127.0.0.1:50868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":29,"request content":"key:\"/registry/ingress\" limit:1 "} {"level":"info","ts":"2026-05-20T20:59:37.860446Z","caller":"traceutil/trace.go:172","msg":"trace[1856636187] range","detail":"{range_begin:/registry/poddisruptionbudgets; range_end:; response_count:0; response_revision:631; }","duration":"273.401837ms","start":"2026-05-20T20:59:37.587037Z","end":"2026-05-20T20:59:37.860439Z","steps":["trace[1856636187] 'agreement among raft nodes before linearized reading' (duration: 268.041545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.860465Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.368024815s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.860510Z","caller":"traceutil/trace.go:172","msg":"trace[868331668] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions; range_end:; response_count:0; response_revision:631; }","duration":"1.368069156s","start":"2026-05-20T20:59:36.492433Z","end":"2026-05-20T20:59:37.860502Z","steps":["trace[868331668] 'agreement among raft nodes before linearized reading' (duration: 1.362738885s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.860545Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:36.492409Z","time spent":"1.368121688s","remote":"127.0.0.1:50424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:37.860570Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.302227132s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.860585Z","caller":"traceutil/trace.go:172","msg":"trace[667216110] range","detail":"{range_begin:/registry/runtimeclasses; range_end:; response_count:0; response_revision:631; }","duration":"1.302240122s","start":"2026-05-20T20:59:36.558340Z","end":"2026-05-20T20:59:37.860580Z","steps":["trace[667216110] 'agreement among raft nodes before linearized reading' (duration: 1.296812718s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.860610Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:36.558325Z","time spent":"1.302271344s","remote":"127.0.0.1:50912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:37.860575Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.520267822s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.860654Z","caller":"traceutil/trace.go:172","msg":"trace[1008181471] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"1.520351705s","start":"2026-05-20T20:59:36.340282Z","end":"2026-05-20T20:59:37.860634Z","steps":["trace[1008181471] 'agreement among raft nodes before linearized reading' (duration: 1.51489739s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.860700Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:36.340256Z","time spent":"1.520434056s","remote":"127.0.0.1:50322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T20:59:37.860713Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.958721566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.860736Z","caller":"traceutil/trace.go:172","msg":"trace[1819557463] range","detail":"{range_begin:/registry/controllers; range_end:; response_count:0; response_revision:631; }","duration":"3.958744256s","start":"2026-05-20T20:59:33.901985Z","end":"2026-05-20T20:59:37.860729Z","steps":["trace[1819557463] 'agreement among raft nodes before linearized reading' (duration: 3.953172689s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.860757Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:33.901964Z","time spent":"3.958787518s","remote":"127.0.0.1:50726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":29,"request content":"key:\"/registry/controllers\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:37.860857Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.341651574s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.860874Z","caller":"traceutil/trace.go:172","msg":"trace[1742207758] range","detail":"{range_begin:/registry/serviceaccounts; range_end:; response_count:0; response_revision:631; }","duration":"1.341668454s","start":"2026-05-20T20:59:36.519200Z","end":"2026-05-20T20:59:37.860868Z","steps":["trace[1742207758] 'agreement among raft nodes before linearized reading' (duration: 1.335964182s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.860877Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"491.474699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:59:37.860892Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:36.519174Z","time spent":"1.341714305s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts\" limit:1 "} {"level":"info","ts":"2026-05-20T20:59:37.860904Z","caller":"traceutil/trace.go:172","msg":"trace[1573436217] range","detail":"{range_begin:/registry/storageclasses; range_end:; response_count:0; response_revision:631; }","duration":"491.542561ms","start":"2026-05-20T20:59:37.369355Z","end":"2026-05-20T20:59:37.860898Z","steps":["trace[1573436217] 'agreement among raft nodes before linearized reading' (duration: 485.740106ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:37.860430Z","caller":"traceutil/trace.go:172","msg":"trace[737434538] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:62; response_revision:631; }","duration":"910.669585ms","start":"2026-05-20T20:59:36.949748Z","end":"2026-05-20T20:59:37.860418Z","steps":["trace[737434538] 'agreement among raft nodes before linearized reading' (duration: 905.394735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.861001Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:37.369337Z","time spent":"491.581783ms","remote":"127.0.0.1:51034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":29,"request content":"key:\"/registry/storageclasses\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:37.861217Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:36.949726Z","time spent":"911.256162ms","remote":"127.0.0.1:51344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":62,"response size":5288,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true "} {"level":"warn","ts":"2026-05-20T20:59:37.861360Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"564.734572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.861410Z","caller":"traceutil/trace.go:172","msg":"trace[839236036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"564.785164ms","start":"2026-05-20T20:59:37.296617Z","end":"2026-05-20T20:59:37.861402Z","steps":["trace[839236036] 'agreement among raft nodes before linearized reading' (duration: 558.486535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.860949Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"5.434946711s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.861560Z","caller":"traceutil/trace.go:172","msg":"trace[1330731404] range","detail":"{range_begin:/registry/networkpolicies; range_end:; response_count:0; response_revision:631; }","duration":"5.435563728s","start":"2026-05-20T20:59:32.425989Z","end":"2026-05-20T20:59:37.861552Z","steps":["trace[1330731404] 'agreement among raft nodes before linearized reading' (duration: 5.429186197s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.861587Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:32.425965Z","time spent":"5.43561419s","remote":"127.0.0.1:50862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":29,"request content":"key:\"/registry/networkpolicies\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:37.860550Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.265664169s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/servicecidrs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:37.861835Z","caller":"traceutil/trace.go:172","msg":"trace[1922347066] range","detail":"{range_begin:/registry/servicecidrs; range_end:; response_count:0; response_revision:631; }","duration":"3.266938716s","start":"2026-05-20T20:59:34.594879Z","end":"2026-05-20T20:59:37.861818Z","steps":["trace[1922347066] 'agreement among raft nodes before linearized reading' (duration: 3.260268027s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.861889Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:34.594857Z","time spent":"3.267016458s","remote":"127.0.0.1:50894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":29,"request content":"key:\"/registry/servicecidrs\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:37.861501Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:37.296600Z","time spent":"564.892786ms","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T20:59:37.860033Z","caller":"traceutil/trace.go:172","msg":"trace[642960015] range","detail":"{range_begin:/registry/csistoragecapacities; range_end:; response_count:0; response_revision:631; }","duration":"1.698102982s","start":"2026-05-20T20:59:36.161916Z","end":"2026-05-20T20:59:37.860019Z","steps":["trace[642960015] 'agreement among raft nodes before linearized reading' (duration: 1.693270424s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.862182Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:36.161894Z","time spent":"1.700264312s","remote":"127.0.0.1:51150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":29,"request content":"key:\"/registry/csistoragecapacities\" limit:1 "} {"level":"info","ts":"2026-05-20T20:59:37.862299Z","caller":"traceutil/trace.go:172","msg":"trace[232359936] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"4.217601847s","start":"2026-05-20T20:59:33.644686Z","end":"2026-05-20T20:59:37.862288Z","steps":["trace[232359936] 'process raft request' (duration: 4.210425783s)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:37.862365Z","caller":"traceutil/trace.go:172","msg":"trace[570680417] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"4.215857298s","start":"2026-05-20T20:59:33.646494Z","end":"2026-05-20T20:59:37.862352Z","steps":["trace[570680417] 'process raft request' (duration: 4.215524838s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:37.862375Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:33.644667Z","time spent":"4.217657569s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:37.862426Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:33.646472Z","time spent":"4.215919s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:38.411480Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"539.264166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:38.411588Z","caller":"traceutil/trace.go:172","msg":"trace[1536275805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"539.372499ms","start":"2026-05-20T20:59:37.872192Z","end":"2026-05-20T20:59:38.411565Z","steps":["trace[1536275805] 'agreement among raft nodes before linearized reading' (duration: 102.003456ms)","trace[1536275805] 'range keys from in-memory index tree' (duration: 437.210598ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:38.411638Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:37.872181Z","time spent":"539.444532ms","remote":"127.0.0.1:50322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T20:59:38.411955Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"437.663321ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:42"} {"level":"info","ts":"2026-05-20T20:59:38.412194Z","caller":"traceutil/trace.go:172","msg":"trace[1958750402] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"413.184109ms","start":"2026-05-20T20:59:37.998991Z","end":"2026-05-20T20:59:38.412175Z","steps":["trace[1958750402] 'read index received' (duration: 412.11703ms)","trace[1958750402] 'applied index is now lower than readState.Index' (duration: 1.066229ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:59:38.412431Z","caller":"traceutil/trace.go:172","msg":"trace[469185621] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"496.757043ms","start":"2026-05-20T20:59:37.915659Z","end":"2026-05-20T20:59:38.412416Z","steps":["trace[469185621] 'process raft request' (duration: 496.65973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:38.412469Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:37.868794Z","time spent":"543.671602ms","remote":"127.0.0.1:50464","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-20T20:59:38.412668Z","caller":"traceutil/trace.go:172","msg":"trace[97030075] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"504.448202ms","start":"2026-05-20T20:59:37.908148Z","end":"2026-05-20T20:59:38.412596Z","steps":["trace[97030075] 'process raft request' (duration: 503.890026ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:38.412681Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"413.649333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:38.412808Z","caller":"traceutil/trace.go:172","msg":"trace[1527450106] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:635; }","duration":"413.808017ms","start":"2026-05-20T20:59:37.998977Z","end":"2026-05-20T20:59:38.412785Z","steps":["trace[1527450106] 'agreement among raft nodes before linearized reading' (duration: 413.486178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:38.412986Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:37.998959Z","time spent":"414.015623ms","remote":"127.0.0.1:50990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":33,"response count":0,"response size":29,"request content":"key:\"/registry/clusterrolebindings\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:38.413070Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:37.908117Z","time spent":"504.703579ms","remote":"127.0.0.1:50378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:38.412562Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:37.915635Z","time spent":"496.860317ms","remote":"127.0.0.1:50682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7692,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:38.810457Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"153.6699ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:38.810530Z","caller":"traceutil/trace.go:172","msg":"trace[1388223028] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:635; }","duration":"153.784684ms","start":"2026-05-20T20:59:38.656732Z","end":"2026-05-20T20:59:38.810517Z","steps":["trace[1388223028] 'range keys from in-memory index tree' (duration: 153.510536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:38.833375Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"660.232475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:38.833467Z","caller":"traceutil/trace.go:172","msg":"trace[1354330254] range","detail":"{range_begin:/registry/daemonsets; range_end:; response_count:0; response_revision:635; }","duration":"660.333737ms","start":"2026-05-20T20:59:38.173113Z","end":"2026-05-20T20:59:38.833447Z","steps":["trace[1354330254] 'agreement among raft nodes before linearized reading' (duration: 660.175693ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:38.833507Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:38.173093Z","time spent":"660.4049ms","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":29,"request content":"key:\"/registry/daemonsets\" limit:1 "} {"level":"info","ts":"2026-05-20T20:59:38.833491Z","caller":"traceutil/trace.go:172","msg":"trace[1019297088] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"559.051188ms","start":"2026-05-20T20:59:38.274413Z","end":"2026-05-20T20:59:38.833464Z","steps":["trace[1019297088] 'process raft request' (duration: 558.819341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:38.833651Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:38.274386Z","time spent":"559.188042ms","remote":"127.0.0.1:50666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4202,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:59:38.833223Z","caller":"traceutil/trace.go:172","msg":"trace[474495690] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:668; }","duration":"420.948541ms","start":"2026-05-20T20:59:38.412237Z","end":"2026-05-20T20:59:38.833186Z","steps":["trace[474495690] 'read index received' (duration: 420.89761ms)","trace[474495690] 'applied index is now lower than readState.Index' (duration: 48.901µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:38.838511Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"415.963989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:59:38.838541Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"421.796345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" limit:1 ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-05-20T20:59:38.838599Z","caller":"traceutil/trace.go:172","msg":"trace[1624065497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"416.051961ms","start":"2026-05-20T20:59:38.422503Z","end":"2026-05-20T20:59:38.838555Z","steps":["trace[1624065497] 'agreement among raft nodes before linearized reading' (duration: 415.924828ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:38.838611Z","caller":"traceutil/trace.go:172","msg":"trace[666811944] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:636; }","duration":"421.878887ms","start":"2026-05-20T20:59:38.416718Z","end":"2026-05-20T20:59:38.838597Z","steps":["trace[666811944] 'agreement among raft nodes before linearized reading' (duration: 421.664161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:38.838649Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:38.416701Z","time spent":"421.940868ms","remote":"127.0.0.1:50638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":446,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" limit:1 "} {"level":"warn","ts":"2026-05-20T20:59:38.838633Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:38.422485Z","time spent":"416.141184ms","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T20:59:38.838655Z","caller":"traceutil/trace.go:172","msg":"trace[1319722570] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"424.244284ms","start":"2026-05-20T20:59:38.414392Z","end":"2026-05-20T20:59:38.838636Z","steps":["trace[1319722570] 'process raft request' (duration: 424.133181ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:38.838693Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"421.171847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-controller\" limit:1 ","response":"range_response_count:1 size:7707"} {"level":"warn","ts":"2026-05-20T20:59:38.838759Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:38.414365Z","time spent":"424.330487ms","remote":"127.0.0.1:50464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":769,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T20:59:38.838762Z","caller":"traceutil/trace.go:172","msg":"trace[1716172463] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-controller; range_end:; response_count:1; response_revision:636; }","duration":"421.256049ms","start":"2026-05-20T20:59:38.417489Z","end":"2026-05-20T20:59:38.838745Z","steps":["trace[1716172463] 'agreement among raft nodes before linearized reading' (duration: 421.042683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:38.838816Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:38.417476Z","time spent":"421.330572ms","remote":"127.0.0.1:50682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":7731,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T20:59:39.004318Z","caller":"traceutil/trace.go:172","msg":"trace[1360986635] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"156.988504ms","start":"2026-05-20T20:59:38.847312Z","end":"2026-05-20T20:59:39.004301Z","steps":["trace[1360986635] 'process raft request' (duration: 118.17247ms)","trace[1360986635] 'compare' (duration: 38.737012ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:59:39.124230Z","caller":"traceutil/trace.go:172","msg":"trace[694644856] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"100.209684ms","start":"2026-05-20T20:59:39.023998Z","end":"2026-05-20T20:59:39.124208Z","steps":["trace[694644856] 'process raft request' (duration: 91.758793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:40.136564Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"291.491055ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-20T20:59:40.136693Z","caller":"traceutil/trace.go:172","msg":"trace[867385804] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"271.652889ms","start":"2026-05-20T20:59:39.865020Z","end":"2026-05-20T20:59:40.136673Z","steps":["trace[867385804] 'read index received' (duration: 24.901µs)","trace[867385804] 'applied index is now lower than readState.Index' (duration: 271.626558ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:40.136923Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"271.882995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:40.137002Z","caller":"traceutil/trace.go:172","msg":"trace[1905646649] range","detail":"{range_begin:/registry/rolebindings; range_end:; response_count:0; response_revision:643; }","duration":"271.968488ms","start":"2026-05-20T20:59:39.865017Z","end":"2026-05-20T20:59:40.136985Z","steps":["trace[1905646649] 'agreement among raft nodes before linearized reading' (duration: 271.839774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:40.153282Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"189.979028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:40.153366Z","caller":"traceutil/trace.go:172","msg":"trace[1345751700] range","detail":"{range_begin:/registry/services/specs; range_end:; response_count:0; response_revision:643; }","duration":"190.075441ms","start":"2026-05-20T20:59:39.963273Z","end":"2026-05-20T20:59:40.153348Z","steps":["trace[1345751700] 'agreement among raft nodes before linearized reading' (duration: 189.921726ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:40.153539Z","caller":"traceutil/trace.go:172","msg":"trace[738420728] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"283.52115ms","start":"2026-05-20T20:59:39.869987Z","end":"2026-05-20T20:59:40.153509Z","steps":["trace[738420728] 'process raft request' (duration: 283.346435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:40.153613Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"168.358949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lcjwl\" limit:1 ","response":"range_response_count:1 size:18620"} {"level":"info","ts":"2026-05-20T20:59:40.153699Z","caller":"traceutil/trace.go:172","msg":"trace[736388480] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lcjwl; range_end:; response_count:1; response_revision:643; }","duration":"168.573265ms","start":"2026-05-20T20:59:39.985106Z","end":"2026-05-20T20:59:40.153680Z","steps":["trace[736388480] 'agreement among raft nodes before linearized reading' (duration: 168.164214ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:40.157611Z","caller":"traceutil/trace.go:172","msg":"trace[154223403] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"171.122309ms","start":"2026-05-20T20:59:39.986478Z","end":"2026-05-20T20:59:40.157600Z","steps":["trace[154223403] 'process raft request' (duration: 171.092698ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:40.157690Z","caller":"traceutil/trace.go:172","msg":"trace[875621079] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"285.796796ms","start":"2026-05-20T20:59:39.871880Z","end":"2026-05-20T20:59:40.157676Z","steps":["trace[875621079] 'process raft request' (duration: 285.58809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:41.119341Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"334.809515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:41.119455Z","caller":"traceutil/trace.go:172","msg":"trace[1045402277] range","detail":"{range_begin:/registry/volumeattachments; range_end:; response_count:0; response_revision:649; }","duration":"334.937878ms","start":"2026-05-20T20:59:40.784500Z","end":"2026-05-20T20:59:41.119438Z","steps":["trace[1045402277] 'range keys from in-memory index tree' (duration: 334.668931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:41.119451Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"462.304864ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:59:41.119492Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:40.784471Z","time spent":"335.012051ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":29,"request content":"key:\"/registry/volumeattachments\" limit:1 "} {"level":"info","ts":"2026-05-20T20:59:41.119512Z","caller":"traceutil/trace.go:172","msg":"trace[911056397] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:649; }","duration":"462.354446ms","start":"2026-05-20T20:59:40.657131Z","end":"2026-05-20T20:59:41.119486Z","steps":["trace[911056397] 'range keys from in-memory index tree' (duration: 462.274284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:41.119701Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"453.901553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:59:41.119678Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"127.677389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lcjwl\" limit:1 ","response":"range_response_count:1 size:18886"} {"level":"info","ts":"2026-05-20T20:59:41.119756Z","caller":"traceutil/trace.go:172","msg":"trace[485336157] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lcjwl; range_end:; response_count:1; response_revision:649; }","duration":"127.772762ms","start":"2026-05-20T20:59:40.991967Z","end":"2026-05-20T20:59:41.119740Z","steps":["trace[485336157] 'range keys from in-memory index tree' (duration: 127.463713ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:41.120626Z","caller":"traceutil/trace.go:172","msg":"trace[1646625789] range","detail":"{range_begin:/registry/controllers; range_end:; response_count:0; response_revision:649; }","duration":"453.930234ms","start":"2026-05-20T20:59:40.665790Z","end":"2026-05-20T20:59:41.119721Z","steps":["trace[1646625789] 'range keys from in-memory index tree' (duration: 453.839461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:41.120793Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:40.665771Z","time spent":"455.005485ms","remote":"127.0.0.1:50726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":29,"request content":"key:\"/registry/controllers\" limit:1 "} {"level":"info","ts":"2026-05-20T20:59:41.474485Z","caller":"traceutil/trace.go:172","msg":"trace[1869552866] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"341.825947ms","start":"2026-05-20T20:59:41.132629Z","end":"2026-05-20T20:59:41.474455Z","steps":["trace[1869552866] 'process raft request' (duration: 341.667642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:41.474621Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:41.132607Z","time spent":"341.945939ms","remote":"127.0.0.1:50682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19044,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:42.004261Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"347.559351ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:59:42.004466Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"216.289397ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:42.004547Z","caller":"traceutil/trace.go:172","msg":"trace[1286598402] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:651; }","duration":"216.40594ms","start":"2026-05-20T20:59:41.788125Z","end":"2026-05-20T20:59:42.004531Z","steps":["trace[1286598402] 'range keys from in-memory index tree' (duration: 216.278457ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:42.004786Z","caller":"traceutil/trace.go:172","msg":"trace[1003517204] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:651; }","duration":"348.095006ms","start":"2026-05-20T20:59:41.656680Z","end":"2026-05-20T20:59:42.004775Z","steps":["trace[1003517204] 'range keys from in-memory index tree' (duration: 347.5065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:42.004775Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"324.467247ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T20:59:42.004861Z","caller":"traceutil/trace.go:172","msg":"trace[243324600] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"262.597271ms","start":"2026-05-20T20:59:41.742253Z","end":"2026-05-20T20:59:42.004851Z","steps":["trace[243324600] 'read index received' (duration: 49.571µs)","trace[243324600] 'applied index is now lower than readState.Index' (duration: 262.54689ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:59:42.004898Z","caller":"traceutil/trace.go:172","msg":"trace[1826535512] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"428.556177ms","start":"2026-05-20T20:59:41.576330Z","end":"2026-05-20T20:59:42.004886Z","steps":["trace[1826535512] 'process raft request' (duration: 103.926016ms)","trace[1826535512] 'compare' (duration: 324.328123ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:42.004986Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"200.549093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T20:59:42.005011Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"262.763715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-20T20:59:42.005018Z","caller":"traceutil/trace.go:172","msg":"trace[1600370691] range","detail":"{range_begin:/registry/statefulsets; range_end:; response_count:0; response_revision:652; }","duration":"200.586124ms","start":"2026-05-20T20:59:41.804424Z","end":"2026-05-20T20:59:42.005010Z","steps":["trace[1600370691] 'agreement among raft nodes before linearized reading' (duration: 200.527352ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:42.005035Z","caller":"traceutil/trace.go:172","msg":"trace[1968134675] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:652; }","duration":"262.791416ms","start":"2026-05-20T20:59:41.742237Z","end":"2026-05-20T20:59:42.005028Z","steps":["trace[1968134675] 'agreement among raft nodes before linearized reading' (duration: 262.681903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:42.005278Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:41.576305Z","time spent":"428.923078ms","remote":"127.0.0.1:50464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":768,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T20:59:42.436760Z","caller":"traceutil/trace.go:172","msg":"trace[332701132] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"277.270881ms","start":"2026-05-20T20:59:42.159464Z","end":"2026-05-20T20:59:42.436735Z","steps":["trace[332701132] 'process raft request' (duration: 277.112446ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:42.473198Z","caller":"traceutil/trace.go:172","msg":"trace[676904022] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"309.219726ms","start":"2026-05-20T20:59:42.163953Z","end":"2026-05-20T20:59:42.473172Z","steps":["trace[676904022] 'process raft request' (duration: 309.069282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:42.473364Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:42.163908Z","time spent":"309.3755ms","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:42.823542Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44544","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:42.844826Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44570","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:42.856019Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44586","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.044299Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44620","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.064457Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44646","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.082530Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44666","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.091814Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"260.765585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:43.091873Z","caller":"traceutil/trace.go:172","msg":"trace[1866941864] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:661; }","duration":"260.832966ms","start":"2026-05-20T20:59:42.831026Z","end":"2026-05-20T20:59:43.091859Z","steps":["trace[1866941864] 'range keys from in-memory index tree' (duration: 260.688992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:43.091844Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"228.48168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:43.092582Z","caller":"traceutil/trace.go:172","msg":"trace[1688035311] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies; range_end:; response_count:0; response_revision:661; }","duration":"229.243411ms","start":"2026-05-20T20:59:42.863315Z","end":"2026-05-20T20:59:43.092558Z","steps":["trace[1688035311] 'range keys from in-memory index tree' (duration: 228.431669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:43.092041Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"240.189928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:43.092752Z","caller":"traceutil/trace.go:172","msg":"trace[90468548] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies; range_end:; response_count:0; response_revision:661; }","duration":"240.905758ms","start":"2026-05-20T20:59:42.851831Z","end":"2026-05-20T20:59:43.092737Z","steps":["trace[90468548] 'range keys from in-memory index tree' (duration: 240.167318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:43.092090Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"240.347373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:43.092970Z","caller":"traceutil/trace.go:172","msg":"trace[98617094] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:661; }","duration":"241.224238ms","start":"2026-05-20T20:59:42.851734Z","end":"2026-05-20T20:59:43.092958Z","steps":["trace[98617094] 'range keys from in-memory index tree' (duration: 240.298721ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:43.092101Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"261.032022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:43.093434Z","caller":"traceutil/trace.go:172","msg":"trace[454859057] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants; range_end:; response_count:0; response_revision:661; }","duration":"262.360771ms","start":"2026-05-20T20:59:42.831063Z","end":"2026-05-20T20:59:43.093423Z","steps":["trace[454859057] 'range keys from in-memory index tree' (duration: 260.994721ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:43.092280Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"229.028005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:43.093935Z","caller":"traceutil/trace.go:172","msg":"trace[1441978909] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:661; }","duration":"230.710524ms","start":"2026-05-20T20:59:42.863212Z","end":"2026-05-20T20:59:43.093923Z","steps":["trace[1441978909] 'range keys from in-memory index tree' (duration: 228.919202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:43.092329Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"125.438206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:43.094391Z","caller":"traceutil/trace.go:172","msg":"trace[1889677999] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:661; }","duration":"127.496015ms","start":"2026-05-20T20:59:42.966882Z","end":"2026-05-20T20:59:43.094378Z","steps":["trace[1889677999] 'range keys from in-memory index tree' (duration: 125.360273ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:43.092376Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"125.317972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:43.094720Z","caller":"traceutil/trace.go:172","msg":"trace[671358377] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes; range_end:; response_count:0; response_revision:661; }","duration":"127.67023ms","start":"2026-05-20T20:59:42.967039Z","end":"2026-05-20T20:59:43.094709Z","steps":["trace[671358377] 'range keys from in-memory index tree' (duration: 125.225089ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:43.105186Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44700","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.126051Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44712","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.143602Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44734","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.172419Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44742","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.199335Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44748","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.288006Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44778","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.311062Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44794","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.331616Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44802","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.352246Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44820","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.374146Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44836","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.413483Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44840","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.462241Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44864","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.610310Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41946","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.656472Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41976","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.670963Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41982","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:43.680647Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41996","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-20T20:59:44.607586Z","caller":"traceutil/trace.go:172","msg":"trace[1473715973] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"127.745132ms","start":"2026-05-20T20:59:44.479784Z","end":"2026-05-20T20:59:44.607529Z","steps":["trace[1473715973] 'process raft request' (duration: 125.61201ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:45.234171Z","caller":"traceutil/trace.go:172","msg":"trace[1883174568] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"177.950061ms","start":"2026-05-20T20:59:45.056199Z","end":"2026-05-20T20:59:45.234149Z","steps":["trace[1883174568] 'process raft request' (duration: 177.703033ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:45.272621Z","caller":"traceutil/trace.go:172","msg":"trace[1978315933] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"206.730465ms","start":"2026-05-20T20:59:45.065869Z","end":"2026-05-20T20:59:45.272599Z","steps":["trace[1978315933] 'process raft request' (duration: 206.57124ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:49.650382Z","caller":"traceutil/trace.go:172","msg":"trace[1773807069] linearizableReadLoop","detail":"{readStateIndex:763; appliedIndex:763; }","duration":"227.879032ms","start":"2026-05-20T20:59:49.422464Z","end":"2026-05-20T20:59:49.650343Z","steps":["trace[1773807069] 'read index received' (duration: 227.868112ms)","trace[1773807069] 'applied index is now lower than readState.Index' (duration: 9.08µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:59:49.651203Z","caller":"traceutil/trace.go:172","msg":"trace[1621349153] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"398.021753ms","start":"2026-05-20T20:59:49.253163Z","end":"2026-05-20T20:59:49.651185Z","steps":["trace[1621349153] 'process raft request' (duration: 397.771335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:49.651264Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"204.977978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" limit:1 ","response":"range_response_count:1 size:9320"} {"level":"warn","ts":"2026-05-20T20:59:49.651316Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:49.253119Z","time spent":"398.134466ms","remote":"127.0.0.1:50424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:59:49.651367Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"228.16691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:49.651415Z","caller":"traceutil/trace.go:172","msg":"trace[850335638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:727; }","duration":"228.945603ms","start":"2026-05-20T20:59:49.422445Z","end":"2026-05-20T20:59:49.651391Z","steps":["trace[850335638] 'agreement among raft nodes before linearized reading' (duration: 228.093568ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:49.651318Z","caller":"traceutil/trace.go:172","msg":"trace[630736652] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:728; }","duration":"205.039491ms","start":"2026-05-20T20:59:49.446267Z","end":"2026-05-20T20:59:49.651307Z","steps":["trace[630736652] 'agreement among raft nodes before linearized reading' (duration: 204.861606ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:49.930682Z","caller":"traceutil/trace.go:172","msg":"trace[1710943779] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:764; }","duration":"273.063419ms","start":"2026-05-20T20:59:49.657584Z","end":"2026-05-20T20:59:49.930647Z","steps":["trace[1710943779] 'read index received' (duration: 273.049378ms)","trace[1710943779] 'applied index is now lower than readState.Index' (duration: 11.991µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:49.930822Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"273.216913ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:49.930891Z","caller":"traceutil/trace.go:172","msg":"trace[1809566876] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:728; }","duration":"273.297805ms","start":"2026-05-20T20:59:49.657578Z","end":"2026-05-20T20:59:49.930876Z","steps":["trace[1809566876] 'agreement among raft nodes before linearized reading' (duration: 273.177452ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:49.930882Z","caller":"traceutil/trace.go:172","msg":"trace[291409953] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"278.11242ms","start":"2026-05-20T20:59:49.652749Z","end":"2026-05-20T20:59:49.930862Z","steps":["trace[291409953] 'process raft request' (duration: 277.996046ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:50.145583Z","caller":"traceutil/trace.go:172","msg":"trace[1680651627] linearizableReadLoop","detail":"{readStateIndex:765; appliedIndex:765; }","duration":"214.777896ms","start":"2026-05-20T20:59:49.930770Z","end":"2026-05-20T20:59:50.145548Z","steps":["trace[1680651627] 'read index received' (duration: 214.763186ms)","trace[1680651627] 'applied index is now lower than readState.Index' (duration: 12.44µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:50.145860Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"299.094291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" limit:1 ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-05-20T20:59:50.145904Z","caller":"traceutil/trace.go:172","msg":"trace[1082230627] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:729; }","duration":"299.160373ms","start":"2026-05-20T20:59:49.846733Z","end":"2026-05-20T20:59:50.145894Z","steps":["trace[1082230627] 'agreement among raft nodes before linearized reading' (duration: 298.963927ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:50.146127Z","caller":"traceutil/trace.go:172","msg":"trace[1027444361] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"482.629981ms","start":"2026-05-20T20:59:49.663474Z","end":"2026-05-20T20:59:50.146104Z","steps":["trace[1027444361] 'process raft request' (duration: 482.289581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:50.146393Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:49.663455Z","time spent":"482.771384ms","remote":"127.0.0.1:50424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13205,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T20:59:50.163701Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"108.180276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-75968c57df-srgwq\" limit:1 ","response":"range_response_count:1 size:5393"} {"level":"info","ts":"2026-05-20T20:59:50.163807Z","caller":"traceutil/trace.go:172","msg":"trace[1846657049] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-75968c57df-srgwq; range_end:; response_count:1; response_revision:730; }","duration":"108.295329ms","start":"2026-05-20T20:59:50.055489Z","end":"2026-05-20T20:59:50.163784Z","steps":["trace[1846657049] 'agreement among raft nodes before linearized reading' (duration: 108.018541ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:50.163983Z","caller":"traceutil/trace.go:172","msg":"trace[1851143396] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"163.745238ms","start":"2026-05-20T20:59:50.000210Z","end":"2026-05-20T20:59:50.163955Z","steps":["trace[1851143396] 'process raft request' (duration: 163.389347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:51.313595Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:42046","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:51.325748Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:42054","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:51.428485Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:42062","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T20:59:51.451234Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:42092","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-20T20:59:53.101073Z","caller":"traceutil/trace.go:172","msg":"trace[416582879] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"162.264872ms","start":"2026-05-20T20:59:52.938779Z","end":"2026-05-20T20:59:53.101044Z","steps":["trace[416582879] 'process raft request' (duration: 162.076286ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:53.142594Z","caller":"traceutil/trace.go:172","msg":"trace[936384651] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"183.826855ms","start":"2026-05-20T20:59:52.958751Z","end":"2026-05-20T20:59:53.142578Z","steps":["trace[936384651] 'process raft request' (duration: 183.755003ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:53.142720Z","caller":"traceutil/trace.go:172","msg":"trace[556670129] transaction","detail":"{read_only:false; number_of_response:0; response_revision:761; }","duration":"203.300352ms","start":"2026-05-20T20:59:52.939397Z","end":"2026-05-20T20:59:53.142698Z","steps":["trace[556670129] 'process raft request' (duration: 202.681664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:53.557292Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58286","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-20T20:59:54.695025Z","caller":"traceutil/trace.go:172","msg":"trace[1045558097] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:804; }","duration":"176.181658ms","start":"2026-05-20T20:59:54.518813Z","end":"2026-05-20T20:59:54.694994Z","steps":["trace[1045558097] 'read index received' (duration: 176.169037ms)","trace[1045558097] 'applied index is now lower than readState.Index' (duration: 10.431µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:54.695246Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"176.424305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:54.695324Z","caller":"traceutil/trace.go:172","msg":"trace[219099839] range","detail":"{range_begin:/registry/namespaces; range_end:; response_count:0; response_revision:766; }","duration":"176.518568ms","start":"2026-05-20T20:59:54.518791Z","end":"2026-05-20T20:59:54.695309Z","steps":["trace[219099839] 'agreement among raft nodes before linearized reading' (duration: 176.355523ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:54.695469Z","caller":"traceutil/trace.go:172","msg":"trace[1875114053] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"191.945046ms","start":"2026-05-20T20:59:54.503497Z","end":"2026-05-20T20:59:54.695442Z","steps":["trace[1875114053] 'process raft request' (duration: 191.560245ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:54.698986Z","caller":"traceutil/trace.go:172","msg":"trace[1504866613] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"162.315195ms","start":"2026-05-20T20:59:54.536643Z","end":"2026-05-20T20:59:54.698958Z","steps":["trace[1504866613] 'process raft request' (duration: 162.089309ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:54.875141Z","caller":"traceutil/trace.go:172","msg":"trace[1997238626] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"104.462631ms","start":"2026-05-20T20:59:54.770663Z","end":"2026-05-20T20:59:54.875125Z","steps":["trace[1997238626] 'process raft request' (duration: 104.295826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:55.160447Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"125.41139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-05-20T20:59:55.160548Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"223.626244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" limit:1 ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-05-20T20:59:55.160775Z","caller":"traceutil/trace.go:172","msg":"trace[537415020] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:770; }","duration":"223.832451ms","start":"2026-05-20T20:59:54.936879Z","end":"2026-05-20T20:59:55.160711Z","steps":["trace[537415020] 'agreement among raft nodes before linearized reading' (duration: 98.037569ms)","trace[537415020] 'range keys from in-memory index tree' (duration: 124.788091ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:59:55.160835Z","caller":"traceutil/trace.go:172","msg":"trace[448554435] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"232.688179ms","start":"2026-05-20T20:59:54.928105Z","end":"2026-05-20T20:59:55.160793Z","steps":["trace[448554435] 'process raft request' (duration: 106.836776ms)","trace[448554435] 'compare' (duration: 124.557404ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:59:55.160976Z","caller":"traceutil/trace.go:172","msg":"trace[892092058] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"126.08449ms","start":"2026-05-20T20:59:55.034874Z","end":"2026-05-20T20:59:55.160958Z","steps":["trace[892092058] 'read index received' (duration: 21.31µs)","trace[892092058] 'applied index is now lower than readState.Index' (duration: 125.965217ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:55.161167Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"197.495621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:55.161586Z","caller":"traceutil/trace.go:172","msg":"trace[352493903] range","detail":"{range_begin:/registry/prioritylevelconfigurations; range_end:; response_count:0; response_revision:771; }","duration":"197.923053ms","start":"2026-05-20T20:59:54.963628Z","end":"2026-05-20T20:59:55.161551Z","steps":["trace[352493903] 'agreement among raft nodes before linearized reading' (duration: 197.295694ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:55.403365Z","caller":"traceutil/trace.go:172","msg":"trace[521470937] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:810; }","duration":"184.400847ms","start":"2026-05-20T20:59:55.218932Z","end":"2026-05-20T20:59:55.403332Z","steps":["trace[521470937] 'read index received' (duration: 184.388397ms)","trace[521470937] 'applied index is now lower than readState.Index' (duration: 10.64µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T20:59:55.411669Z","caller":"traceutil/trace.go:172","msg":"trace[2113429815] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"241.763203ms","start":"2026-05-20T20:59:55.169886Z","end":"2026-05-20T20:59:55.411649Z","steps":["trace[2113429815] 'process raft request' (duration: 233.614596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:55.411781Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"192.820633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lcjwl\" limit:1 ","response":"range_response_count:1 size:20086"} {"level":"info","ts":"2026-05-20T20:59:55.411860Z","caller":"traceutil/trace.go:172","msg":"trace[834001578] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lcjwl; range_end:; response_count:1; response_revision:771; }","duration":"192.914376ms","start":"2026-05-20T20:59:55.218928Z","end":"2026-05-20T20:59:55.411842Z","steps":["trace[834001578] 'agreement among raft nodes before linearized reading' (duration: 184.49876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:55.478814Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"119.920492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:55.478905Z","caller":"traceutil/trace.go:172","msg":"trace[194524163] range","detail":"{range_begin:/registry/deployments; range_end:; response_count:0; response_revision:772; }","duration":"120.029876ms","start":"2026-05-20T20:59:55.358860Z","end":"2026-05-20T20:59:55.478890Z","steps":["trace[194524163] 'agreement among raft nodes before linearized reading' (duration: 119.86657ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:55.478904Z","caller":"traceutil/trace.go:172","msg":"trace[1511237702] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"302.954897ms","start":"2026-05-20T20:59:55.175910Z","end":"2026-05-20T20:59:55.478864Z","steps":["trace[1511237702] 'process raft request' (duration: 302.834803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T20:59:55.479001Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T20:59:55.175890Z","time spent":"303.057311ms","remote":"127.0.0.1:42050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2372,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T20:59:55.479335Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"213.262785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:94 size:8044"} {"level":"info","ts":"2026-05-20T20:59:55.479407Z","caller":"traceutil/trace.go:172","msg":"trace[1074438331] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:94; response_revision:773; }","duration":"213.349918ms","start":"2026-05-20T20:59:55.266043Z","end":"2026-05-20T20:59:55.479393Z","steps":["trace[1074438331] 'agreement among raft nodes before linearized reading' (duration: 212.78032ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:55.591337Z","caller":"traceutil/trace.go:172","msg":"trace[1947984729] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:812; }","duration":"112.58751ms","start":"2026-05-20T20:59:55.478689Z","end":"2026-05-20T20:59:55.591276Z","steps":["trace[1947984729] 'read index received' (duration: 112.574449ms)","trace[1947984729] 'applied index is now lower than readState.Index' (duration: 11.171µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T20:59:55.593763Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"173.911687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T20:59:55.593841Z","caller":"traceutil/trace.go:172","msg":"trace[135254518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:773; }","duration":"174.016371ms","start":"2026-05-20T20:59:55.419808Z","end":"2026-05-20T20:59:55.593824Z","steps":["trace[135254518] 'agreement among raft nodes before linearized reading' (duration: 171.642128ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:55.594064Z","caller":"traceutil/trace.go:172","msg":"trace[1782519164] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"172.216035ms","start":"2026-05-20T20:59:55.421832Z","end":"2026-05-20T20:59:55.594048Z","steps":["trace[1782519164] 'process raft request' (duration: 169.505542ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T20:59:55.594050Z","caller":"traceutil/trace.go:172","msg":"trace[726037041] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"163.945294ms","start":"2026-05-20T20:59:55.430086Z","end":"2026-05-20T20:59:55.594032Z","steps":["trace[726037041] 'process raft request' (duration: 163.83648ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:00:01.222768Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:00:01.723709Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:00:02.224394Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186427989175601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:00:02.354288Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.63168038s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T21:00:02.354538Z","caller":"traceutil/trace.go:172","msg":"trace[1522777243] linearizableReadLoop","detail":"{readStateIndex:850; appliedIndex:850; }","duration":"1.631782173s","start":"2026-05-20T21:00:00.722721Z","end":"2026-05-20T21:00:02.354503Z","steps":["trace[1522777243] 'read index received' (duration: 1.631762443s)","trace[1522777243] 'applied index is now lower than readState.Index' (duration: 12.95µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:00:02.354767Z","caller":"traceutil/trace.go:172","msg":"trace[513168670] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"1.632276628s","start":"2026-05-20T21:00:00.722468Z","end":"2026-05-20T21:00:02.354745Z","steps":["trace[513168670] 'process raft request' (duration: 1.632099962s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:00:02.354808Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.632076672s","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:494"} {"level":"info","ts":"2026-05-20T21:00:02.354855Z","caller":"traceutil/trace.go:172","msg":"trace[2107740202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:810; }","duration":"1.632136934s","start":"2026-05-20T21:00:00.722702Z","end":"2026-05-20T21:00:02.354839Z","steps":["trace[2107740202] 'agreement among raft nodes before linearized reading' (duration: 1.631945198s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:00:02.354896Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:00:00.722666Z","time spent":"1.632216796s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:00:02.354918Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:00:00.722443Z","time spent":"1.632400132s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:00:02.382821Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"713.446017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:00:02.382834Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.309820245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceclaimtemplates\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:00:02.382902Z","caller":"traceutil/trace.go:172","msg":"trace[1413053066] range","detail":"{range_begin:/registry/persistentvolumeclaims; range_end:; response_count:0; response_revision:811; }","duration":"713.53677ms","start":"2026-05-20T21:00:01.669347Z","end":"2026-05-20T21:00:02.382883Z","steps":["trace[1413053066] 'agreement among raft nodes before linearized reading' (duration: 713.402386ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:00:02.382916Z","caller":"traceutil/trace.go:172","msg":"trace[1455515562] range","detail":"{range_begin:/registry/resourceclaimtemplates; range_end:; response_count:0; response_revision:811; }","duration":"1.309918788s","start":"2026-05-20T21:00:01.072980Z","end":"2026-05-20T21:00:02.382899Z","steps":["trace[1455515562] 'agreement among raft nodes before linearized reading' (duration: 1.309760993s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:00:02.382944Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:00:01.669324Z","time spent":"713.611352ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumeclaims\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:00:02.382924Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"771.339415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:00:02.383004Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.281409984s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:00:02.383012Z","caller":"traceutil/trace.go:172","msg":"trace[1735593121] range","detail":"{range_begin:/registry/endpointslices; range_end:; response_count:0; response_revision:811; }","duration":"771.443868ms","start":"2026-05-20T21:00:01.611552Z","end":"2026-05-20T21:00:02.382996Z","steps":["trace[1735593121] 'agreement among raft nodes before linearized reading' (duration: 771.278753ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:00:02.383056Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:00:01.611521Z","time spent":"771.525222ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":29,"request content":"key:\"/registry/endpointslices\" limit:1 "} {"level":"info","ts":"2026-05-20T21:00:02.383107Z","caller":"traceutil/trace.go:172","msg":"trace[626202823] range","detail":"{range_begin:/registry/roles; range_end:; response_count:0; response_revision:811; }","duration":"1.281506847s","start":"2026-05-20T21:00:01.101588Z","end":"2026-05-20T21:00:02.383095Z","steps":["trace[626202823] 'agreement among raft nodes before linearized reading' (duration: 1.281392343s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:00:02.384325Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:00:01.101564Z","time spent":"1.282745415s","remote":"127.0.0.1:50936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":19,"response count":0,"response size":29,"request content":"key:\"/registry/roles\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:00:02.383209Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"274.811188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:00:02.384457Z","caller":"traceutil/trace.go:172","msg":"trace[1982179606] range","detail":"{range_begin:/registry/csinodes; range_end:; response_count:0; response_revision:811; }","duration":"276.378758ms","start":"2026-05-20T21:00:02.108055Z","end":"2026-05-20T21:00:02.384433Z","steps":["trace[1982179606] 'agreement among raft nodes before linearized reading' (duration: 274.741606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:00:02.382960Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:00:01.072957Z","time spent":"1.309994421s","remote":"127.0.0.1:51362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/resourceclaimtemplates\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:00:02.383137Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"725.11967ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:00:02.384752Z","caller":"traceutil/trace.go:172","msg":"trace[537484341] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:811; }","duration":"726.813803ms","start":"2026-05-20T21:00:01.657917Z","end":"2026-05-20T21:00:02.384731Z","steps":["trace[537484341] 'agreement among raft nodes before linearized reading' (duration: 725.09772ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:00:02.383488Z","caller":"traceutil/trace.go:172","msg":"trace[598059491] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"1.489912067s","start":"2026-05-20T21:00:00.893561Z","end":"2026-05-20T21:00:02.383473Z","steps":["trace[598059491] 'process raft request' (duration: 1.489708881s)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:00:02.383488Z","caller":"traceutil/trace.go:172","msg":"trace[1432265995] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"1.236646654s","start":"2026-05-20T21:00:01.146824Z","end":"2026-05-20T21:00:02.383471Z","steps":["trace[1432265995] 'process raft request' (duration: 1.236590942s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:00:02.385664Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:00:01.146795Z","time spent":"1.238544642s","remote":"127.0.0.1:50762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2879,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:00:02.385936Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:00:00.893539Z","time spent":"1.492321243s","remote":"127.0.0.1:50828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:00:02.384198Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"632.942709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:00:02.386350Z","caller":"traceutil/trace.go:172","msg":"trace[4069181] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations; range_end:; response_count:0; response_revision:813; }","duration":"635.121437ms","start":"2026-05-20T21:00:01.751212Z","end":"2026-05-20T21:00:02.386334Z","steps":["trace[4069181] 'agreement among raft nodes before linearized reading' (duration: 632.853376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:00:02.386458Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:00:01.751188Z","time spent":"635.253321ms","remote":"127.0.0.1:51286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 "} {"level":"info","ts":"2026-05-20T21:00:03.529573Z","caller":"traceutil/trace.go:172","msg":"trace[1950516838] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"137.467074ms","start":"2026-05-20T21:00:03.392085Z","end":"2026-05-20T21:00:03.529552Z","steps":["trace[1950516838] 'process raft request' (duration: 137.325289ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:00:04.692357Z","caller":"traceutil/trace.go:172","msg":"trace[572496156] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"203.375151ms","start":"2026-05-20T21:00:04.488956Z","end":"2026-05-20T21:00:04.692331Z","steps":["trace[572496156] 'process raft request' (duration: 199.225971ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:00:10.702477Z","caller":"traceutil/trace.go:172","msg":"trace[1175844496] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"200.418981ms","start":"2026-05-20T21:00:10.502036Z","end":"2026-05-20T21:00:10.702455Z","steps":["trace[1175844496] 'process raft request' (duration: 200.194094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:00:14.733337Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58060","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:00:14.860116Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58080","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:00:14.869422Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58110","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:00:14.882754Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58124","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:00:40.162681Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"200.37443ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-20T21:00:40.162789Z","caller":"traceutil/trace.go:172","msg":"trace[590969646] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"180.996096ms","start":"2026-05-20T21:00:39.981774Z","end":"2026-05-20T21:00:40.162770Z","steps":["trace[590969646] 'read index received' (duration: 27.841µs)","trace[590969646] 'applied index is now lower than readState.Index' (duration: 180.966825ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:00:40.162871Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"181.092929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:00:40.162913Z","caller":"traceutil/trace.go:172","msg":"trace[378452690] range","detail":"{range_begin:/registry/services/specs; range_end:; response_count:0; response_revision:953; }","duration":"181.1373ms","start":"2026-05-20T21:00:39.981764Z","end":"2026-05-20T21:00:40.162901Z","steps":["trace[378452690] 'agreement among raft nodes before linearized reading' (duration: 181.060688ms)"],"step_count":1}