{"level":"warn","ts":"2026-05-14T10:17:26.788459Z","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-14T10:17:26.788608Z","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-14T10:17:26.788653Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.27:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.19.213.27:2380","--initial-cluster=controller=https://199.19.213.27:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.27:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.27: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-14T10:17:26.788762Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-05-14T10:17:26.788791Z","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-14T10:17:26.788804Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.27:2380"]} {"level":"info","ts":"2026-05-14T10:17:26.788829Z","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-14T10:17:26.789425Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"]} {"level":"info","ts":"2026-05-14T10:17:26.789647Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.27:2380"],"listen-peer-urls":["https://199.19.213.27:2380"],"advertise-client-urls":["https://199.19.213.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.19.213.27: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-14T10:17:26.790612Z","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: 0xc00011e498}"} {"level":"info","ts":"2026-05-14T10:17:26.799469Z","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-14T10:17:26.799580Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.083825ms"} {"level":"info","ts":"2026-05-14T10:17:26.799629Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-05-14T10:17:26.799678Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-05-14T10:17:26.799729Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-05-14T10:17:26.825991Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-05-14T10:17:26.826103Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"d0494904b1be7692","cluster-id":"7c10a1b21fbd6dff"} {"level":"info","ts":"2026-05-14T10:17:26.826130Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-05-14T10:17:26.826202Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d0494904b1be7692 switched to configuration voters=()"} {"level":"info","ts":"2026-05-14T10:17:26.826253Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"d0494904b1be7692 became follower at term 0"} {"level":"info","ts":"2026-05-14T10:17:26.826261Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft d0494904b1be7692 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-14T10:17:26.826282Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"d0494904b1be7692 became follower at term 1"} {"level":"info","ts":"2026-05-14T10:17:26.826324Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d0494904b1be7692 switched to configuration voters=(15008607517699634834)"} {"level":"warn","ts":"2026-05-14T10:17:26.839071Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-14T10:17:26.844960Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-14T10:17:26.855011Z","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-14T10:17:26.855919Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"d0494904b1be7692","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-14T10:17:26.856203Z","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-14T10:17:26.856233Z","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-14T10:17:26.856103Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0494904b1be7692","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-14T10:17:26.856347Z","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-14T10:17:26.856380Z","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-14T10:17:26.856365Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.19.213.27:2380"} {"level":"info","ts":"2026-05-14T10:17:26.856478Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.19.213.27:2380"} {"level":"info","ts":"2026-05-14T10:17:26.856789Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"d0494904b1be7692","initial-advertise-peer-urls":["https://199.19.213.27:2380"],"listen-peer-urls":["https://199.19.213.27:2380"],"advertise-client-urls":["https://199.19.213.27:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.27:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-14T10:17:26.856867Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-14T10:17:26.860532Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d0494904b1be7692 switched to configuration voters=(15008607517699634834)"} {"level":"info","ts":"2026-05-14T10:17:26.860762Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"7c10a1b21fbd6dff","local-member-id":"d0494904b1be7692","added-peer-id":"d0494904b1be7692","added-peer-peer-urls":["https://199.19.213.27:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-05-14T10:17:27.226423Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"d0494904b1be7692 is starting a new election at term 1"} {"level":"info","ts":"2026-05-14T10:17:27.226505Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"d0494904b1be7692 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-14T10:17:27.228943Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"d0494904b1be7692 received MsgPreVoteResp from d0494904b1be7692 at term 1"} {"level":"info","ts":"2026-05-14T10:17:27.228988Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"d0494904b1be7692 has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-14T10:17:27.229024Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"d0494904b1be7692 became candidate at term 2"} {"level":"info","ts":"2026-05-14T10:17:27.258422Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"d0494904b1be7692 received MsgVoteResp from d0494904b1be7692 at term 2"} {"level":"info","ts":"2026-05-14T10:17:27.258493Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"d0494904b1be7692 has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-14T10:17:27.258537Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"d0494904b1be7692 became leader at term 2"} {"level":"info","ts":"2026-05-14T10:17:27.258556Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: d0494904b1be7692 elected leader d0494904b1be7692 at term 2"} {"level":"info","ts":"2026-05-14T10:17:27.264818Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"d0494904b1be7692","local-member-attributes":"{Name:controller ClientURLs:[https://199.19.213.27:2379]}","cluster-id":"7c10a1b21fbd6dff","publish-timeout":"7s"} {"level":"info","ts":"2026-05-14T10:17:27.264863Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-05-14T10:17:27.264999Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T10:17:27.265111Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T10:17:27.265344Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-14T10:17:27.265421Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-14T10:17:27.267543Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"7c10a1b21fbd6dff","local-member-id":"d0494904b1be7692","cluster-version":"3.6"} {"level":"info","ts":"2026-05-14T10:17:27.267696Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-05-14T10:17:27.267693Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-05-14T10:17:27.267772Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-05-14T10:17:27.267882Z","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-14T10:17:27.268000Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"warn","ts":"2026-05-14T10:17:27.272284Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-05-14T10:17:27.272625Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-05-14T10:17:27.276571Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.27:2379"} {"level":"info","ts":"2026-05-14T10:17:27.276968Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-14T10:17:27.428402Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52754","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.456598Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52790","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.469391Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52798","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.497423Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52848","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.526323Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52872","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.534661Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52890","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.543153Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52896","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.550407Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52916","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.558993Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52928","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.578305Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52950","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.583335Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52970","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.593031Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52978","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.602138Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53022","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.610360Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53038","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.619352Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53046","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.641036Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53068","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.670908Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53104","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.685694Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53122","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.729151Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53126","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.739217Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53140","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.751865Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53160","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.767554Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53182","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.772056Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53198","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.783769Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53204","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.794473Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53214","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.804069Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53240","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.816726Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53260","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.829123Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53286","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.846207Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53306","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.857491Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53324","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.865155Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53338","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.881483Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53346","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.887436Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53354","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.896024Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53366","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.910631Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53384","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.925966Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53406","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.939441Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53428","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.949701Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53442","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.960972Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53450","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.972469Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53462","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.982926Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53478","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:27.994113Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53510","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.008617Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53526","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.036865Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53530","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.050129Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53556","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.065733Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53592","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.069945Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53606","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.083032Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53620","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.088043Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53632","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.098434Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53660","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.108371Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53682","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.115920Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53700","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.125719Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53726","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.139191Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53754","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.155505Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53768","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.179693Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53796","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.195672Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53822","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:17:28.203747Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53834","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-14T10:17:36.097251Z","caller":"traceutil/trace.go:172","msg":"trace[1111221314] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"744.043786ms","start":"2026-05-14T10:17:35.353186Z","end":"2026-05-14T10:17:36.097230Z","steps":["trace[1111221314] 'process raft request' (duration: 743.923494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:36.097972Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:35.353162Z","time spent":"744.35238ms","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T10:17:36.327445Z","caller":"traceutil/trace.go:172","msg":"trace[747551738] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:318; }","duration":"207.900184ms","start":"2026-05-14T10:17:36.119443Z","end":"2026-05-14T10:17:36.327344Z","steps":["trace[747551738] 'read index received' (duration: 207.886224ms)","trace[747551738] 'applied index is now lower than readState.Index' (duration: 11.73µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:36.376769Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"257.32437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:17:36.376890Z","caller":"traceutil/trace.go:172","msg":"trace[933167165] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:0; response_revision:302; }","duration":"257.467012ms","start":"2026-05-14T10:17:36.119404Z","end":"2026-05-14T10:17:36.376871Z","steps":["trace[933167165] 'agreement among raft nodes before linearized reading' (duration: 208.027086ms)","trace[933167165] 'range keys from in-memory index tree' (duration: 49.250973ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:17:36.376863Z","caller":"traceutil/trace.go:172","msg":"trace[820964207] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"259.130558ms","start":"2026-05-14T10:17:36.117714Z","end":"2026-05-14T10:17:36.376844Z","steps":["trace[820964207] 'process raft request' (duration: 209.660821ms)","trace[820964207] 'compare' (duration: 49.373435ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:17:42.796752Z","caller":"traceutil/trace.go:172","msg":"trace[746129741] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:402; }","duration":"351.446567ms","start":"2026-05-14T10:17:42.445273Z","end":"2026-05-14T10:17:42.796720Z","steps":["trace[746129741] 'read index received' (duration: 351.432977ms)","trace[746129741] 'applied index is now lower than readState.Index' (duration: 11.22µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:42.797022Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"351.732291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-14T10:17:42.797102Z","caller":"traceutil/trace.go:172","msg":"trace[151308846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:384; }","duration":"351.827463ms","start":"2026-05-14T10:17:42.445258Z","end":"2026-05-14T10:17:42.797085Z","steps":["trace[151308846] 'agreement among raft nodes before linearized reading' (duration: 351.569039ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:42.797143Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:42.445233Z","time spent":"351.901243ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-05-14T10:17:42.797151Z","caller":"traceutil/trace.go:172","msg":"trace[1756707011] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"558.804757ms","start":"2026-05-14T10:17:42.238304Z","end":"2026-05-14T10:17:42.797108Z","steps":["trace[1756707011] 'process raft request' (duration: 558.622944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:42.797799Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:42.238280Z","time spent":"558.945939ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":528,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:17:42.831581Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"151.193806ms","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-14T10:17:42.831591Z","caller":"traceutil/trace.go:172","msg":"trace[1467074696] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"436.654115ms","start":"2026-05-14T10:17:42.394913Z","end":"2026-05-14T10:17:42.831567Z","steps":["trace[1467074696] 'process raft request' (duration: 436.510433ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:42.831640Z","caller":"traceutil/trace.go:172","msg":"trace[1902876990] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:386; }","duration":"151.255097ms","start":"2026-05-14T10:17:42.680371Z","end":"2026-05-14T10:17:42.831626Z","steps":["trace[1902876990] 'agreement among raft nodes before linearized reading' (duration: 151.162765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:42.831758Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:42.394887Z","time spent":"436.777236ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:17:48.184167Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"501.539037ms","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-14T10:17:48.184256Z","caller":"traceutil/trace.go:172","msg":"trace[1284229364] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:398; }","duration":"501.637159ms","start":"2026-05-14T10:17:47.682601Z","end":"2026-05-14T10:17:48.184239Z","steps":["trace[1284229364] 'range keys from in-memory index tree' (duration: 501.484607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:48.184176Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"530.612148ms","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-14T10:17:48.184356Z","caller":"traceutil/trace.go:172","msg":"trace[324803339] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:398; }","duration":"530.800481ms","start":"2026-05-14T10:17:47.653546Z","end":"2026-05-14T10:17:48.184346Z","steps":["trace[324803339] 'range keys from in-memory index tree' (duration: 530.409945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:48.184387Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:47.653525Z","time spent":"530.851442ms","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4361,"request content":"key:\"/registry/deployments/kube-system/coredns\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:17:49.181775Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083329999,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T10:17:49.263944Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.063927371s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T10:17:49.264273Z","caller":"traceutil/trace.go:172","msg":"trace[1542393543] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:417; }","duration":"583.310713ms","start":"2026-05-14T10:17:48.680926Z","end":"2026-05-14T10:17:49.264237Z","steps":["trace[1542393543] 'read index received' (duration: 583.301903ms)","trace[1542393543] 'applied index is now lower than readState.Index' (duration: 7.29µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:49.264420Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"583.486315ms","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-14T10:17:49.264450Z","caller":"traceutil/trace.go:172","msg":"trace[1540506152] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:398; }","duration":"583.530856ms","start":"2026-05-14T10:17:48.680910Z","end":"2026-05-14T10:17:49.264440Z","steps":["trace[1540506152] 'agreement among raft nodes before linearized reading' (duration: 583.456095ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:49.264544Z","caller":"traceutil/trace.go:172","msg":"trace[416690161] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"1.064592621s","start":"2026-05-14T10:17:48.199930Z","end":"2026-05-14T10:17:49.264523Z","steps":["trace[416690161] 'process raft request' (duration: 1.064384468s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:49.264687Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:48.199914Z","time spent":"1.064708113s","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:49.617013Z","caller":"traceutil/trace.go:172","msg":"trace[130380539] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:418; }","duration":"352.65361ms","start":"2026-05-14T10:17:49.264340Z","end":"2026-05-14T10:17:49.616994Z","steps":["trace[130380539] 'read index received' (duration: 352.64598ms)","trace[130380539] 'applied index is now lower than readState.Index' (duration: 6.59µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:49.617108Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"791.207024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:17:49.617143Z","caller":"traceutil/trace.go:172","msg":"trace[1717335941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:399; }","duration":"791.253354ms","start":"2026-05-14T10:17:48.825884Z","end":"2026-05-14T10:17:49.617137Z","steps":["trace[1717335941] 'agreement among raft nodes before linearized reading' (duration: 791.185043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:49.617174Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:48.825860Z","time spent":"791.308785ms","remote":"127.0.0.1:52770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T10:17:49.617322Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"757.467691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-14T10:17:49.617439Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"392.900313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-14T10:17:49.617558Z","caller":"traceutil/trace.go:172","msg":"trace[1555461032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:399; }","duration":"393.016995ms","start":"2026-05-14T10:17:49.224528Z","end":"2026-05-14T10:17:49.617545Z","steps":["trace[1555461032] 'agreement among raft nodes before linearized reading' (duration: 392.474696ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:49.617633Z","caller":"traceutil/trace.go:172","msg":"trace[630884562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:399; }","duration":"757.522272ms","start":"2026-05-14T10:17:48.859839Z","end":"2026-05-14T10:17:49.617361Z","steps":["trace[630884562] 'agreement among raft nodes before linearized reading' (duration: 757.329109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:49.617666Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:48.859817Z","time spent":"757.841138ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-05-14T10:17:49.617791Z","caller":"traceutil/trace.go:172","msg":"trace[721164030] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"765.200721ms","start":"2026-05-14T10:17:48.852567Z","end":"2026-05-14T10:17:49.617768Z","steps":["trace[721164030] 'process raft request' (duration: 764.661163ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:49.618072Z","caller":"traceutil/trace.go:172","msg":"trace[717233527] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"621.109241ms","start":"2026-05-14T10:17:48.996950Z","end":"2026-05-14T10:17:49.618059Z","steps":["trace[717233527] 'process raft request' (duration: 620.629993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:49.618518Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:48.996923Z","time spent":"621.552708ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:17:49.617590Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:49.224483Z","time spent":"393.098046ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-05-14T10:17:49.618160Z","caller":"traceutil/trace.go:172","msg":"trace[788509824] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"595.617537ms","start":"2026-05-14T10:17:49.022527Z","end":"2026-05-14T10:17:49.618144Z","steps":["trace[788509824] 'process raft request' (duration: 595.423044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:49.618720Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:49.022499Z","time spent":"596.197596ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":674,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:17:49.618941Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:48.852541Z","time spent":"765.511016ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:49.918061Z","caller":"traceutil/trace.go:172","msg":"trace[1079930343] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:421; }","duration":"299.569322ms","start":"2026-05-14T10:17:49.618471Z","end":"2026-05-14T10:17:49.918040Z","steps":["trace[1079930343] 'read index received' (duration: 299.561191ms)","trace[1079930343] 'applied index is now lower than readState.Index' (duration: 7.281µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:50.377725Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"759.232292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:17:50.377801Z","caller":"traceutil/trace.go:172","msg":"trace[654183788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:402; }","duration":"759.317513ms","start":"2026-05-14T10:17:49.618468Z","end":"2026-05-14T10:17:50.377785Z","steps":["trace[654183788] 'agreement among raft nodes before linearized reading' (duration: 299.658143ms)","trace[654183788] 'range keys from in-memory index tree' (duration: 459.546368ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:50.377832Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:49.618453Z","time spent":"759.373514ms","remote":"127.0.0.1:52752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T10:17:50.378375Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"460.002135ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:17:50.378580Z","caller":"traceutil/trace.go:172","msg":"trace[97309130] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"755.766358ms","start":"2026-05-14T10:17:49.622799Z","end":"2026-05-14T10:17:50.378565Z","steps":["trace[97309130] 'process raft request' (duration: 755.729877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:50.378651Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:49.622791Z","time spent":"755.825159ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:50.378828Z","caller":"traceutil/trace.go:172","msg":"trace[1480528064] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"1.102900914s","start":"2026-05-14T10:17:49.275915Z","end":"2026-05-14T10:17:50.378816Z","steps":["trace[1480528064] 'process raft request' (duration: 642.261739ms)","trace[1480528064] 'compare' (duration: 459.68221ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:50.378873Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:49.275886Z","time spent":"1.102969664s","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3960,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T10:17:50.378944Z","caller":"traceutil/trace.go:172","msg":"trace[1034347149] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:421; }","duration":"460.824478ms","start":"2026-05-14T10:17:49.918110Z","end":"2026-05-14T10:17:50.378935Z","steps":["trace[1034347149] 'read index received' (duration: 280.018136ms)","trace[1034347149] 'applied index is now lower than readState.Index' (duration: 180.805452ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:50.378991Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"697.948124ms","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-14T10:17:50.379019Z","caller":"traceutil/trace.go:172","msg":"trace[1618514850] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:405; }","duration":"697.976495ms","start":"2026-05-14T10:17:49.681035Z","end":"2026-05-14T10:17:50.379012Z","steps":["trace[1618514850] 'agreement among raft nodes before linearized reading' (duration: 697.928624ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:50.379042Z","caller":"traceutil/trace.go:172","msg":"trace[1547038292] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"756.968986ms","start":"2026-05-14T10:17:49.622062Z","end":"2026-05-14T10:17:50.379031Z","steps":["trace[1547038292] 'process raft request' (duration: 756.402967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:50.379786Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:49.622040Z","time spent":"757.027498ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:50.769211Z","caller":"traceutil/trace.go:172","msg":"trace[1631749269] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:425; }","duration":"306.519053ms","start":"2026-05-14T10:17:50.462657Z","end":"2026-05-14T10:17:50.769176Z","steps":["trace[1631749269] 'read index received' (duration: 306.506203ms)","trace[1631749269] 'applied index is now lower than readState.Index' (duration: 10.88µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:50.862106Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"399.428749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.27\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-14T10:17:50.862234Z","caller":"traceutil/trace.go:172","msg":"trace[2076938789] range","detail":"{range_begin:/registry/masterleases/199.19.213.27; range_end:; response_count:1; response_revision:406; }","duration":"399.560851ms","start":"2026-05-14T10:17:50.462647Z","end":"2026-05-14T10:17:50.862208Z","steps":["trace[2076938789] 'agreement among raft nodes before linearized reading' (duration: 306.650066ms)","trace[2076938789] 'range keys from in-memory index tree' (duration: 92.615801ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:50.862286Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:50.462630Z","time spent":"399.643772ms","remote":"127.0.0.1:52808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.27\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:17:50.862108Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"181.601614ms","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-14T10:17:50.862584Z","caller":"traceutil/trace.go:172","msg":"trace[1212828444] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"477.617636ms","start":"2026-05-14T10:17:50.384942Z","end":"2026-05-14T10:17:50.862560Z","steps":["trace[1212828444] 'process raft request' (duration: 384.276095ms)","trace[1212828444] 'compare' (duration: 92.856614ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:17:50.862613Z","caller":"traceutil/trace.go:172","msg":"trace[1338792489] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:406; }","duration":"182.152773ms","start":"2026-05-14T10:17:50.680430Z","end":"2026-05-14T10:17:50.862582Z","steps":["trace[1338792489] 'range keys from in-memory index tree' (duration: 181.496443ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:50.862637Z","caller":"traceutil/trace.go:172","msg":"trace[185679599] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"476.59958ms","start":"2026-05-14T10:17:50.386004Z","end":"2026-05-14T10:17:50.862603Z","steps":["trace[185679599] 'process raft request' (duration: 476.230064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:50.862693Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:50.384922Z","time spent":"477.705227ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3848,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T10:17:50.862736Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:50.385994Z","time spent":"476.688511ms","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:17:51.457043Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"264.079193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:17:51.457225Z","caller":"traceutil/trace.go:172","msg":"trace[338387565] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"585.003347ms","start":"2026-05-14T10:17:50.872204Z","end":"2026-05-14T10:17:51.457207Z","steps":["trace[338387565] 'process raft request' (duration: 320.68546ms)","trace[338387565] 'compare' (duration: 263.83185ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:51.457330Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:50.872170Z","time spent":"585.102118ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4378,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:51.457393Z","caller":"traceutil/trace.go:172","msg":"trace[1110930456] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"585.001827ms","start":"2026-05-14T10:17:50.872380Z","end":"2026-05-14T10:17:51.457382Z","steps":["trace[1110930456] 'process raft request' (duration: 584.757423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:51.457438Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:50.872368Z","time spent":"585.047687ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4086,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:51.457524Z","caller":"traceutil/trace.go:172","msg":"trace[1287420841] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"583.557765ms","start":"2026-05-14T10:17:50.873952Z","end":"2026-05-14T10:17:51.457510Z","steps":["trace[1287420841] 'process raft request' (duration: 583.385012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:51.457570Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:50.873944Z","time spent":"583.608266ms","remote":"127.0.0.1:52892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T10:17:51.457583Z","caller":"traceutil/trace.go:172","msg":"trace[1929137882] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"495.590376ms","start":"2026-05-14T10:17:50.961980Z","end":"2026-05-14T10:17:51.457570Z","steps":["trace[1929137882] 'process raft request' (duration: 495.550975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:51.457652Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:50.961942Z","time spent":"495.675858ms","remote":"127.0.0.1:52808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:51.457699Z","caller":"traceutil/trace.go:172","msg":"trace[1313475884] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"583.489784ms","start":"2026-05-14T10:17:50.874202Z","end":"2026-05-14T10:17:51.457692Z","steps":["trace[1313475884] 'process raft request' (duration: 583.25402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:51.457737Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:50.874179Z","time spent":"583.539624ms","remote":"127.0.0.1:52892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":858,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T10:17:51.457761Z","caller":"traceutil/trace.go:172","msg":"trace[686613474] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"581.506183ms","start":"2026-05-14T10:17:50.876248Z","end":"2026-05-14T10:17:51.457754Z","steps":["trace[686613474] 'process raft request' (duration: 581.239499ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:51.457807Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:50.876239Z","time spent":"581.538343ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4077,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:17:51.677375Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"210.301744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" limit:1 ","response":"range_response_count:1 size:475"} {"level":"info","ts":"2026-05-14T10:17:51.677517Z","caller":"traceutil/trace.go:172","msg":"trace[1560170332] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"211.367141ms","start":"2026-05-14T10:17:51.466126Z","end":"2026-05-14T10:17:51.677494Z","steps":["trace[1560170332] 'process raft request' (duration: 158.611247ms)","trace[1560170332] 'compare' (duration: 52.440569ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:17:51.677539Z","caller":"traceutil/trace.go:172","msg":"trace[158021850] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:415; }","duration":"210.478017ms","start":"2026-05-14T10:17:51.467042Z","end":"2026-05-14T10:17:51.677520Z","steps":["trace[158021850] 'agreement among raft nodes before linearized reading' (duration: 157.433239ms)","trace[158021850] 'range keys from in-memory index tree' (duration: 52.737944ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:51.677391Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"209.207778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7488bc8bd5\" limit:1 ","response":"range_response_count:1 size:4092"} {"level":"info","ts":"2026-05-14T10:17:51.678739Z","caller":"traceutil/trace.go:172","msg":"trace[1748436517] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7488bc8bd5; range_end:; response_count:1; response_revision:415; }","duration":"209.928569ms","start":"2026-05-14T10:17:51.468145Z","end":"2026-05-14T10:17:51.678074Z","steps":["trace[1748436517] 'agreement among raft nodes before linearized reading' (duration: 156.350812ms)","trace[1748436517] 'range keys from in-memory index tree' (duration: 52.727123ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:17:51.686648Z","caller":"traceutil/trace.go:172","msg":"trace[1795559760] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"145.323791ms","start":"2026-05-14T10:17:51.541289Z","end":"2026-05-14T10:17:51.686613Z","steps":["trace[1795559760] 'process raft request' (duration: 145.2275ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:51.973739Z","caller":"traceutil/trace.go:172","msg":"trace[1337840673] linearizableReadLoop","detail":"{readStateIndex:449; appliedIndex:449; }","duration":"223.740222ms","start":"2026-05-14T10:17:51.749932Z","end":"2026-05-14T10:17:51.973672Z","steps":["trace[1337840673] 'read index received' (duration: 223.730371ms)","trace[1337840673] 'applied index is now lower than readState.Index' (duration: 8.101µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:17:52.065824Z","caller":"traceutil/trace.go:172","msg":"trace[1242894729] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"326.653709ms","start":"2026-05-14T10:17:51.739127Z","end":"2026-05-14T10:17:52.065781Z","steps":["trace[1242894729] 'process raft request' (duration: 326.452146ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:52.065912Z","caller":"traceutil/trace.go:172","msg":"trace[1550397681] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"326.550197ms","start":"2026-05-14T10:17:51.739342Z","end":"2026-05-14T10:17:52.065892Z","steps":["trace[1550397681] 'process raft request' (duration: 326.324293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:52.065836Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"315.843622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-66bc5c9577\" limit:1 ","response":"range_response_count:1 size:4101"} {"level":"warn","ts":"2026-05-14T10:17:52.066026Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:51.739323Z","time spent":"326.648679ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4122,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:17:52.066041Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:51.739119Z","time spent":"326.808861ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4378,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:52.066068Z","caller":"traceutil/trace.go:172","msg":"trace[781456864] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-66bc5c9577; range_end:; response_count:1; response_revision:427; }","duration":"316.115706ms","start":"2026-05-14T10:17:51.749928Z","end":"2026-05-14T10:17:52.066043Z","steps":["trace[781456864] 'agreement among raft nodes before linearized reading' (duration: 223.904634ms)","trace[781456864] 'range keys from in-memory index tree' (duration: 91.562492ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:52.066127Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:51.749911Z","time spent":"316.200217ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":4124,"request content":"key:\"/registry/replicasets/kube-system/coredns-66bc5c9577\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:17:52.065775Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"238.136853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:17:52.066459Z","caller":"traceutil/trace.go:172","msg":"trace[1427863724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:430; }","duration":"238.831504ms","start":"2026-05-14T10:17:51.827612Z","end":"2026-05-14T10:17:52.066444Z","steps":["trace[1427863724] 'agreement among raft nodes before linearized reading' (duration: 238.108053ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:52.065710Z","caller":"traceutil/trace.go:172","msg":"trace[171995492] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"327.657014ms","start":"2026-05-14T10:17:51.737971Z","end":"2026-05-14T10:17:52.065628Z","steps":["trace[171995492] 'process raft request' (duration: 235.762717ms)","trace[171995492] 'compare' (duration: 91.540521ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:52.066647Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:51.737953Z","time spent":"328.593379ms","remote":"127.0.0.1:52892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":858,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T10:17:52.499223Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"193.178877ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:17:52.499383Z","caller":"traceutil/trace.go:172","msg":"trace[1404015658] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"422.121396ms","start":"2026-05-14T10:17:52.077244Z","end":"2026-05-14T10:17:52.499365Z","steps":["trace[1404015658] 'process raft request' (duration: 228.734625ms)","trace[1404015658] 'compare' (duration: 193.070556ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:52.499441Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:52.077211Z","time spent":"422.204786ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4086,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:52.499606Z","caller":"traceutil/trace.go:172","msg":"trace[955698057] linearizableReadLoop","detail":"{readStateIndex:455; appliedIndex:453; }","duration":"112.90831ms","start":"2026-05-14T10:17:52.386669Z","end":"2026-05-14T10:17:52.499577Z","steps":["trace[955698057] 'read index received' (duration: 44.641µs)","trace[955698057] 'applied index is now lower than readState.Index' (duration: 112.861949ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:52.499850Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"113.175464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-14T10:17:52.499887Z","caller":"traceutil/trace.go:172","msg":"trace[1455312620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:433; }","duration":"113.214265ms","start":"2026-05-14T10:17:52.386664Z","end":"2026-05-14T10:17:52.499878Z","steps":["trace[1455312620] 'agreement among raft nodes before linearized reading' (duration: 113.107133ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:52.500033Z","caller":"traceutil/trace.go:172","msg":"trace[1086605967] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"410.70557ms","start":"2026-05-14T10:17:52.089318Z","end":"2026-05-14T10:17:52.500023Z","steps":["trace[1086605967] 'process raft request' (duration: 409.992059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:52.500092Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:52.089292Z","time spent":"410.77246ms","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:17:52.500976Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"114.122409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-14T10:17:52.501047Z","caller":"traceutil/trace.go:172","msg":"trace[266239292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:433; }","duration":"114.20276ms","start":"2026-05-14T10:17:52.386829Z","end":"2026-05-14T10:17:52.501032Z","steps":["trace[266239292] 'agreement among raft nodes before linearized reading' (duration: 113.103143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:53.328913Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330062,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-14T10:17:53.395122Z","caller":"traceutil/trace.go:172","msg":"trace[269639728] linearizableReadLoop","detail":"{readStateIndex:457; appliedIndex:457; }","duration":"566.522343ms","start":"2026-05-14T10:17:52.828579Z","end":"2026-05-14T10:17:53.395101Z","steps":["trace[269639728] 'read index received' (duration: 566.507453ms)","trace[269639728] 'applied index is now lower than readState.Index' (duration: 7.44µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:55.033658Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330065,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T10:17:55.534728Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330065,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T10:17:55.750012Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.354882244s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-14T10:17:55.756673Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.049357549s","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-14T10:17:55.756739Z","caller":"traceutil/trace.go:172","msg":"trace[1733983785] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:435; }","duration":"3.04943852s","start":"2026-05-14T10:17:52.707288Z","end":"2026-05-14T10:17:55.756727Z","steps":["trace[1733983785] 'range keys from in-memory index tree' (duration: 3.049306169s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:55.756810Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.013993017s","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-14T10:17:55.756867Z","caller":"traceutil/trace.go:172","msg":"trace[80553342] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:435; }","duration":"2.014020357s","start":"2026-05-14T10:17:53.742810Z","end":"2026-05-14T10:17:55.756830Z","steps":["trace[80553342] 'range keys from in-memory index tree' (duration: 2.013912676s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:55.757289Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.92872275s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:17:55.757306Z","caller":"traceutil/trace.go:172","msg":"trace[212310261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:435; }","duration":"2.92873895s","start":"2026-05-14T10:17:52.828561Z","end":"2026-05-14T10:17:55.757300Z","steps":["trace[212310261] 'agreement among raft nodes before linearized reading' (duration: 566.615535ms)","trace[212310261] 'range keys from in-memory index tree' (duration: 2.362094135s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:55.757322Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:52.828485Z","time spent":"2.928832982s","remote":"127.0.0.1:52770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T10:17:55.757536Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.362319469s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:17:55.757721Z","caller":"traceutil/trace.go:172","msg":"trace[1724669916] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"2.601051284s","start":"2026-05-14T10:17:53.156653Z","end":"2026-05-14T10:17:55.757705Z","steps":["trace[1724669916] 'process raft request' (duration: 2.600968823s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:55.757780Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:53.156626Z","time spent":"2.601126995s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":528,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:55.757798Z","caller":"traceutil/trace.go:172","msg":"trace[1608200351] linearizableReadLoop","detail":"{readStateIndex:458; appliedIndex:457; }","duration":"1.225063279s","start":"2026-05-14T10:17:54.532726Z","end":"2026-05-14T10:17:55.757789Z","steps":["trace[1608200351] 'read index received' (duration: 1.217511153s)","trace[1608200351] 'applied index is now lower than readState.Index' (duration: 7.551426ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:17:55.757838Z","caller":"traceutil/trace.go:172","msg":"trace[1459070281] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"3.221949809s","start":"2026-05-14T10:17:52.535882Z","end":"2026-05-14T10:17:55.757832Z","steps":["trace[1459070281] 'process raft request' (duration: 859.265015ms)","trace[1459070281] 'compare' (duration: 2.362107376s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:55.757893Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:52.535861Z","time spent":"3.22199136s","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:17:55.758043Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.225327753s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-14T10:17:55.758056Z","caller":"traceutil/trace.go:172","msg":"trace[1643246055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:437; }","duration":"1.225341133s","start":"2026-05-14T10:17:54.532711Z","end":"2026-05-14T10:17:55.758052Z","steps":["trace[1643246055] 'agreement among raft nodes before linearized reading' (duration: 1.225275552s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:55.758069Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:54.532690Z","time spent":"1.225374984s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-05-14T10:17:55.994234Z","caller":"traceutil/trace.go:172","msg":"trace[478800523] linearizableReadLoop","detail":"{readStateIndex:459; appliedIndex:459; }","duration":"236.395302ms","start":"2026-05-14T10:17:55.757812Z","end":"2026-05-14T10:17:55.994207Z","steps":["trace[478800523] 'read index received' (duration: 236.385852ms)","trace[478800523] 'applied index is now lower than readState.Index' (duration: 8.13µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:17:56.000161Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.170922752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:17:56.000268Z","caller":"traceutil/trace.go:172","msg":"trace[241825432] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:437; }","duration":"1.171041054s","start":"2026-05-14T10:17:54.829207Z","end":"2026-05-14T10:17:56.000248Z","steps":["trace[241825432] 'agreement among raft nodes before linearized reading' (duration: 1.165114953s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:56.000200Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.427900035s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-14T10:17:56.000367Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:54.829185Z","time spent":"1.171167366s","remote":"127.0.0.1:52752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-14T10:17:56.000380Z","caller":"traceutil/trace.go:172","msg":"trace[1497561241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:437; }","duration":"1.428082378s","start":"2026-05-14T10:17:54.572288Z","end":"2026-05-14T10:17:56.000371Z","steps":["trace[1497561241] 'agreement among raft nodes before linearized reading' (duration: 1.422013194s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:56.000412Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:54.572265Z","time spent":"1.428139058s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:17:56.001000Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"244.214322ms","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-14T10:17:56.001143Z","caller":"traceutil/trace.go:172","msg":"trace[908253440] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"2.288690847s","start":"2026-05-14T10:17:53.712443Z","end":"2026-05-14T10:17:56.001134Z","steps":["trace[908253440] 'process raft request' (duration: 2.288637397s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:56.001221Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:53.712412Z","time spent":"2.288760499s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:56.001190Z","caller":"traceutil/trace.go:172","msg":"trace[1733465626] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"2.28883678s","start":"2026-05-14T10:17:53.712317Z","end":"2026-05-14T10:17:56.001154Z","steps":["trace[1733465626] 'process raft request' (duration: 2.282307879s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:56.001458Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:53.712292Z","time spent":"2.289038414s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:17:56.001061Z","caller":"traceutil/trace.go:172","msg":"trace[730042257] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:437; }","duration":"244.275693ms","start":"2026-05-14T10:17:55.756771Z","end":"2026-05-14T10:17:56.001046Z","steps":["trace[730042257] 'agreement among raft nodes before linearized reading' (duration: 237.54992ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:56.007820Z","caller":"traceutil/trace.go:172","msg":"trace[2058356779] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"246.225823ms","start":"2026-05-14T10:17:55.761570Z","end":"2026-05-14T10:17:56.007796Z","steps":["trace[2058356779] 'process raft request' (duration: 245.697055ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:56.229669Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"222.232901ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-05-14T10:17:56.229834Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"225.032413ms","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-14T10:17:56.229883Z","caller":"traceutil/trace.go:172","msg":"trace[499740477] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:440; }","duration":"225.079604ms","start":"2026-05-14T10:17:56.004785Z","end":"2026-05-14T10:17:56.229865Z","steps":["trace[499740477] 'range keys from in-memory index tree' (duration: 222.004377ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:56.230004Z","caller":"traceutil/trace.go:172","msg":"trace[825816720] linearizableReadLoop","detail":"{readStateIndex:463; appliedIndex:462; }","duration":"214.926149ms","start":"2026-05-14T10:17:56.015062Z","end":"2026-05-14T10:17:56.229989Z","steps":["trace[825816720] 'read index received' (duration: 64.542661ms)","trace[825816720] 'applied index is now lower than readState.Index' (duration: 150.382148ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:17:56.230089Z","caller":"traceutil/trace.go:172","msg":"trace[1374714537] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"223.924316ms","start":"2026-05-14T10:17:56.006155Z","end":"2026-05-14T10:17:56.230080Z","steps":["trace[1374714537] 'process raft request' (duration: 223.615032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:17:56.298816Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"283.730585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:17:56.298897Z","caller":"traceutil/trace.go:172","msg":"trace[597278068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:441; }","duration":"283.819637ms","start":"2026-05-14T10:17:56.015059Z","end":"2026-05-14T10:17:56.298878Z","steps":["trace[597278068] 'agreement among raft nodes before linearized reading' (duration: 214.9767ms)","trace[597278068] 'range keys from in-memory index tree' (duration: 68.709275ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:17:56.300225Z","caller":"traceutil/trace.go:172","msg":"trace[406190261] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"284.769661ms","start":"2026-05-14T10:17:56.014663Z","end":"2026-05-14T10:17:56.299433Z","steps":["trace[406190261] 'process raft request' (duration: 215.411556ms)","trace[406190261] 'compare' (duration: 68.762796ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:17:58.258795Z","caller":"traceutil/trace.go:172","msg":"trace[1096135040] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"252.098372ms","start":"2026-05-14T10:17:58.006670Z","end":"2026-05-14T10:17:58.258768Z","steps":["trace[1096135040] 'process raft request' (duration: 251.905779ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:17:58.259996Z","caller":"traceutil/trace.go:172","msg":"trace[981496357] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"180.422924ms","start":"2026-05-14T10:17:58.079539Z","end":"2026-05-14T10:17:58.259962Z","steps":["trace[981496357] 'process raft request' (duration: 180.227851ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:00.044728Z","caller":"traceutil/trace.go:172","msg":"trace[776945531] linearizableReadLoop","detail":"{readStateIndex:469; appliedIndex:469; }","duration":"363.562264ms","start":"2026-05-14T10:17:59.681132Z","end":"2026-05-14T10:18:00.044694Z","steps":["trace[776945531] 'read index received' (duration: 363.552444ms)","trace[776945531] 'applied index is now lower than readState.Index' (duration: 8.4µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:00.044930Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"363.770617ms","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-14T10:18:00.044986Z","caller":"traceutil/trace.go:172","msg":"trace[599281340] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:446; }","duration":"363.844838ms","start":"2026-05-14T10:17:59.681120Z","end":"2026-05-14T10:18:00.044964Z","steps":["trace[599281340] 'agreement among raft nodes before linearized reading' (duration: 363.728496ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:00.045159Z","caller":"traceutil/trace.go:172","msg":"trace[1166798044] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"372.416429ms","start":"2026-05-14T10:17:59.672682Z","end":"2026-05-14T10:18:00.045098Z","steps":["trace[1166798044] 'process raft request' (duration: 372.079064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:00.045362Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"311.929124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:00.045392Z","caller":"traceutil/trace.go:172","msg":"trace[1663042246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:447; }","duration":"311.960174ms","start":"2026-05-14T10:17:59.733423Z","end":"2026-05-14T10:18:00.045383Z","steps":["trace[1663042246] 'agreement among raft nodes before linearized reading' (duration: 311.890083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:00.045428Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:59.733391Z","time spent":"312.030245ms","remote":"127.0.0.1:52770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T10:18:00.045743Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"218.423293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:00.045825Z","caller":"traceutil/trace.go:172","msg":"trace[1131276213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:447; }","duration":"218.513614ms","start":"2026-05-14T10:17:59.827299Z","end":"2026-05-14T10:18:00.045813Z","steps":["trace[1131276213] 'agreement among raft nodes before linearized reading' (duration: 218.404342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:00.045827Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:17:59.672647Z","time spent":"372.734524ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:06.436625Z","caller":"traceutil/trace.go:172","msg":"trace[230419704] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"110.764785ms","start":"2026-05-14T10:18:06.325777Z","end":"2026-05-14T10:18:06.436542Z","steps":["trace[230419704] 'process raft request' (duration: 110.703304ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.436640Z","caller":"traceutil/trace.go:172","msg":"trace[1677520362] transaction","detail":"{read_only:false; number_of_response:1; response_revision:503; }","duration":"112.831726ms","start":"2026-05-14T10:18:06.323784Z","end":"2026-05-14T10:18:06.436616Z","steps":["trace[1677520362] 'process raft request' (duration: 112.524502ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.520680Z","caller":"traceutil/trace.go:172","msg":"trace[143068426] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"187.022095ms","start":"2026-05-14T10:18:06.333631Z","end":"2026-05-14T10:18:06.520653Z","steps":["trace[143068426] 'process raft request' (duration: 186.69774ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539357Z","caller":"traceutil/trace.go:172","msg":"trace[1491562942] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"199.564666ms","start":"2026-05-14T10:18:06.339749Z","end":"2026-05-14T10:18:06.539314Z","steps":["trace[1491562942] 'process raft request' (duration: 199.376993ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539399Z","caller":"traceutil/trace.go:172","msg":"trace[1860588802] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"197.663046ms","start":"2026-05-14T10:18:06.341705Z","end":"2026-05-14T10:18:06.539368Z","steps":["trace[1860588802] 'process raft request' (duration: 197.523754ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539513Z","caller":"traceutil/trace.go:172","msg":"trace[1701738011] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"181.588873ms","start":"2026-05-14T10:18:06.357917Z","end":"2026-05-14T10:18:06.539506Z","steps":["trace[1701738011] 'process raft request' (duration: 181.335749ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539538Z","caller":"traceutil/trace.go:172","msg":"trace[354289074] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"170.553684ms","start":"2026-05-14T10:18:06.368968Z","end":"2026-05-14T10:18:06.539522Z","steps":["trace[354289074] 'process raft request' (duration: 170.377231ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539637Z","caller":"traceutil/trace.go:172","msg":"trace[712408123] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"168.368311ms","start":"2026-05-14T10:18:06.371251Z","end":"2026-05-14T10:18:06.539619Z","steps":["trace[712408123] 'process raft request' (duration: 168.118678ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539664Z","caller":"traceutil/trace.go:172","msg":"trace[1017705034] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"165.63714ms","start":"2026-05-14T10:18:06.374019Z","end":"2026-05-14T10:18:06.539656Z","steps":["trace[1017705034] 'process raft request' (duration: 165.417157ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539685Z","caller":"traceutil/trace.go:172","msg":"trace[1935943340] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"164.682085ms","start":"2026-05-14T10:18:06.374997Z","end":"2026-05-14T10:18:06.539679Z","steps":["trace[1935943340] 'process raft request' (duration: 164.552173ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539637Z","caller":"traceutil/trace.go:172","msg":"trace[1431170399] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"174.176339ms","start":"2026-05-14T10:18:06.365435Z","end":"2026-05-14T10:18:06.539611Z","steps":["trace[1431170399] 'process raft request' (duration: 173.868415ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539708Z","caller":"traceutil/trace.go:172","msg":"trace[1961256224] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"115.042211ms","start":"2026-05-14T10:18:06.424659Z","end":"2026-05-14T10:18:06.539701Z","steps":["trace[1961256224] 'process raft request' (duration: 115.0163ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539733Z","caller":"traceutil/trace.go:172","msg":"trace[1820588424] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"163.71448ms","start":"2026-05-14T10:18:06.376013Z","end":"2026-05-14T10:18:06.539728Z","steps":["trace[1820588424] 'process raft request' (duration: 163.603248ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.539742Z","caller":"traceutil/trace.go:172","msg":"trace[1127359493] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"136.787301ms","start":"2026-05-14T10:18:06.402949Z","end":"2026-05-14T10:18:06.539736Z","steps":["trace[1127359493] 'process raft request' (duration: 136.69738ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.545653Z","caller":"traceutil/trace.go:172","msg":"trace[261340486] transaction","detail":"{read_only:false; number_of_response:1; response_revision:508; }","duration":"177.857145ms","start":"2026-05-14T10:18:06.361633Z","end":"2026-05-14T10:18:06.539491Z","steps":["trace[261340486] 'process raft request' (duration: 177.651512ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.635379Z","caller":"traceutil/trace.go:172","msg":"trace[873438163] transaction","detail":"{read_only:false; number_of_response:1; response_revision:517; }","duration":"184.325423ms","start":"2026-05-14T10:18:06.451032Z","end":"2026-05-14T10:18:06.635357Z","steps":["trace[873438163] 'process raft request' (duration: 184.293013ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.635626Z","caller":"traceutil/trace.go:172","msg":"trace[1418870160] transaction","detail":"{read_only:false; number_of_response:0; response_revision:516; }","duration":"193.553204ms","start":"2026-05-14T10:18:06.442043Z","end":"2026-05-14T10:18:06.635596Z","steps":["trace[1418870160] 'process raft request' (duration: 193.150938ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.635684Z","caller":"traceutil/trace.go:172","msg":"trace[775812451] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"193.185749ms","start":"2026-05-14T10:18:06.442467Z","end":"2026-05-14T10:18:06.635653Z","steps":["trace[775812451] 'process raft request' (duration: 192.797653ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.647935Z","caller":"traceutil/trace.go:172","msg":"trace[201818952] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"103.789728ms","start":"2026-05-14T10:18:06.544117Z","end":"2026-05-14T10:18:06.647907Z","steps":["trace[201818952] 'process raft request' (duration: 98.312305ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:06.649080Z","caller":"traceutil/trace.go:172","msg":"trace[2130954769] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"100.829264ms","start":"2026-05-14T10:18:06.548229Z","end":"2026-05-14T10:18:06.649058Z","steps":["trace[2130954769] 'process raft request' (duration: 98.922505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.029836Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38192","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-14T10:18:07.056701Z","caller":"traceutil/trace.go:172","msg":"trace[2026020166] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:556; }","duration":"227.980227ms","start":"2026-05-14T10:18:06.828699Z","end":"2026-05-14T10:18:07.056679Z","steps":["trace[2026020166] 'read index received' (duration: 227.971997ms)","trace[2026020166] 'applied index is now lower than readState.Index' (duration: 6.65µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:07.062994Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38216","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:07.073505Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38232","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:07.557173Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330241,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T10:18:07.780865Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"100.496307ms","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-14T10:18:07.780892Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"952.169672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:07.780950Z","caller":"traceutil/trace.go:172","msg":"trace[1008280616] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:526; }","duration":"100.602928ms","start":"2026-05-14T10:18:07.680329Z","end":"2026-05-14T10:18:07.780932Z","steps":["trace[1008280616] 'range keys from in-memory index tree' (duration: 100.435316ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:07.780970Z","caller":"traceutil/trace.go:172","msg":"trace[1657398237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:526; }","duration":"952.258784ms","start":"2026-05-14T10:18:06.828692Z","end":"2026-05-14T10:18:07.780951Z","steps":["trace[1657398237] 'agreement among raft nodes before linearized reading' (duration: 228.119169ms)","trace[1657398237] 'range keys from in-memory index tree' (duration: 724.008103ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:07.781008Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:06.828660Z","time spent":"952.339914ms","remote":"127.0.0.1:52770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T10:18:07.781242Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"724.200835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:18:07.781638Z","caller":"traceutil/trace.go:172","msg":"trace[1033560151] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.100285395s","start":"2026-05-14T10:18:06.681335Z","end":"2026-05-14T10:18:07.781621Z","steps":["trace[1033560151] 'process raft request' (duration: 375.45189ms)","trace[1033560151] 'compare' (duration: 724.035443ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:07.781713Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:06.681313Z","time spent":"1.100365346s","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:07.782122Z","caller":"traceutil/trace.go:172","msg":"trace[943129014] transaction","detail":"{read_only:false; number_of_response:1; response_revision:527; }","duration":"1.089955788s","start":"2026-05-14T10:18:06.692154Z","end":"2026-05-14T10:18:07.782110Z","steps":["trace[943129014] 'process raft request' (duration: 1.089379409s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.782180Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:06.692126Z","time spent":"1.090028769s","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":96,"response count":0,"response size":30444,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:07.782232Z","caller":"traceutil/trace.go:172","msg":"trace[1216181008] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:556; }","duration":"725.432774ms","start":"2026-05-14T10:18:07.056783Z","end":"2026-05-14T10:18:07.782215Z","steps":["trace[1216181008] 'read index received' (duration: 724.668772ms)","trace[1216181008] 'applied index is now lower than readState.Index' (duration: 762.032µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:07.782350Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"734.706485ms","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-14T10:18:07.782384Z","caller":"traceutil/trace.go:172","msg":"trace[805958884] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants; range_end:; response_count:0; response_revision:527; }","duration":"734.744265ms","start":"2026-05-14T10:18:07.047631Z","end":"2026-05-14T10:18:07.782375Z","steps":["trace[805958884] 'agreement among raft nodes before linearized reading' (duration: 734.683874ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.782416Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:07.047614Z","time spent":"734.795167ms","remote":"127.0.0.1:38202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:07.782343Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"734.639814ms","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-14T10:18:07.782486Z","caller":"traceutil/trace.go:172","msg":"trace[597531139] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:527; }","duration":"734.797997ms","start":"2026-05-14T10:18:07.047671Z","end":"2026-05-14T10:18:07.782469Z","steps":["trace[597531139] 'agreement among raft nodes before linearized reading' (duration: 734.559993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.782524Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:07.047667Z","time spent":"734.847497ms","remote":"127.0.0.1:38202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-05-14T10:18:07.782845Z","caller":"traceutil/trace.go:172","msg":"trace[278408203] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.071403836s","start":"2026-05-14T10:18:06.711427Z","end":"2026-05-14T10:18:07.782830Z","steps":["trace[278408203] 'process raft request' (duration: 1.070843708s)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:07.782936Z","caller":"traceutil/trace.go:172","msg":"trace[475737284] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.060338978s","start":"2026-05-14T10:18:06.722584Z","end":"2026-05-14T10:18:07.782923Z","steps":["trace[475737284] 'process raft request' (duration: 1.060154085s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.783001Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:06.722567Z","time spent":"1.060395958s","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:07.782997Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:06.711404Z","time spent":"1.071515598s","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:07.783477Z","caller":"traceutil/trace.go:172","msg":"trace[2018778957] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.059777949s","start":"2026-05-14T10:18:06.723651Z","end":"2026-05-14T10:18:07.783429Z","steps":["trace[2018778957] 'process raft request' (duration: 1.059550436s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.783632Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:06.723618Z","time spent":"1.059943411s","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:07.783658Z","caller":"traceutil/trace.go:172","msg":"trace[488757931] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"1.055545565s","start":"2026-05-14T10:18:06.728095Z","end":"2026-05-14T10:18:07.783640Z","steps":["trace[488757931] 'process raft request' (duration: 1.05521552s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.783757Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:06.728049Z","time spent":"1.055650257s","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:07.783784Z","caller":"traceutil/trace.go:172","msg":"trace[434949787] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.039797266s","start":"2026-05-14T10:18:06.743971Z","end":"2026-05-14T10:18:07.783768Z","steps":["trace[434949787] 'process raft request' (duration: 1.039478461s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.784592Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:06.743953Z","time spent":"1.040611408s","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T10:18:07.784743Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"701.701883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:07.784787Z","caller":"traceutil/trace.go:172","msg":"trace[607467567] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses; range_end:; response_count:0; response_revision:533; }","duration":"701.747754ms","start":"2026-05-14T10:18:07.083029Z","end":"2026-05-14T10:18:07.784776Z","steps":["trace[607467567] 'agreement among raft nodes before linearized reading' (duration: 701.682283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.784817Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:07.083017Z","time spent":"701.791924ms","remote":"127.0.0.1:38246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:07.784900Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"713.398472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:07.784939Z","caller":"traceutil/trace.go:172","msg":"trace[1781540056] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:533; }","duration":"713.440012ms","start":"2026-05-14T10:18:07.071490Z","end":"2026-05-14T10:18:07.784930Z","steps":["trace[1781540056] 'agreement among raft nodes before linearized reading' (duration: 713.378451ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:07.785023Z","caller":"traceutil/trace.go:172","msg":"trace[1642538304] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.005651126s","start":"2026-05-14T10:18:06.779360Z","end":"2026-05-14T10:18:07.785012Z","steps":["trace[1642538304] 'process raft request' (duration: 1.004415287s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.785086Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:06.779330Z","time spent":"1.005725487s","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:07.785765Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"702.956143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:07.785804Z","caller":"traceutil/trace.go:172","msg":"trace[780154992] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:533; }","duration":"702.996123ms","start":"2026-05-14T10:18:07.082798Z","end":"2026-05-14T10:18:07.785794Z","steps":["trace[780154992] 'agreement among raft nodes before linearized reading' (duration: 702.943373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.785830Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:07.082778Z","time spent":"703.044384ms","remote":"127.0.0.1:38246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-14T10:18:07.785863Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"713.446612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:07.785951Z","caller":"traceutil/trace.go:172","msg":"trace[1036605296] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses; range_end:; response_count:0; response_revision:533; }","duration":"714.449018ms","start":"2026-05-14T10:18:07.071489Z","end":"2026-05-14T10:18:07.785938Z","steps":["trace[1036605296] 'agreement among raft nodes before linearized reading' (duration: 713.427702ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:07.786037Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:07.071475Z","time spent":"714.504068ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:07.788559Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:07.071478Z","time spent":"713.484553ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-14T10:18:08.551092Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330244,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-14T10:18:08.557351Z","caller":"traceutil/trace.go:172","msg":"trace[920858966] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:565; }","duration":"507.07794ms","start":"2026-05-14T10:18:08.050239Z","end":"2026-05-14T10:18:08.557317Z","steps":["trace[920858966] 'read index received' (duration: 507.06434ms)","trace[920858966] 'applied index is now lower than readState.Index' (duration: 11.82µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:08.599311Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"549.048857ms","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-14T10:18:08.599396Z","caller":"traceutil/trace.go:172","msg":"trace[577726214] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants; range_end:; response_count:0; response_revision:534; }","duration":"549.135879ms","start":"2026-05-14T10:18:08.050234Z","end":"2026-05-14T10:18:08.599370Z","steps":["trace[577726214] 'agreement among raft nodes before linearized reading' (duration: 507.239362ms)","trace[577726214] 'range keys from in-memory index tree' (duration: 41.725124ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:08.599434Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:08.050215Z","time spent":"549.21042ms","remote":"127.0.0.1:38202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants\" limit:1 "} {"level":"info","ts":"2026-05-14T10:18:08.599827Z","caller":"traceutil/trace.go:172","msg":"trace[2074008832] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"791.751386ms","start":"2026-05-14T10:18:07.808024Z","end":"2026-05-14T10:18:08.599775Z","steps":["trace[2074008832] 'process raft request' (duration: 749.447343ms)","trace[2074008832] 'compare' (duration: 42.12241ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:08.599989Z","caller":"traceutil/trace.go:172","msg":"trace[2140876731] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"306.089858ms","start":"2026-05-14T10:18:08.293886Z","end":"2026-05-14T10:18:08.599975Z","steps":["trace[2140876731] 'process raft request' (duration: 306.057797ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:08.600020Z","caller":"traceutil/trace.go:172","msg":"trace[1031472523] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"755.319182ms","start":"2026-05-14T10:18:07.844664Z","end":"2026-05-14T10:18:08.599983Z","steps":["trace[1031472523] 'process raft request' (duration: 755.063658ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:08.600028Z","caller":"traceutil/trace.go:172","msg":"trace[194858281] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"730.555525ms","start":"2026-05-14T10:18:07.869444Z","end":"2026-05-14T10:18:08.600000Z","steps":["trace[194858281] 'process raft request' (duration: 730.400753ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:08.600083Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:07.844637Z","time spent":"755.405903ms","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:08.600085Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:08.293859Z","time spent":"306.17517ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:08.600135Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:07.869411Z","time spent":"730.675968ms","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T10:18:08.600251Z","caller":"traceutil/trace.go:172","msg":"trace[911978594] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"486.297045ms","start":"2026-05-14T10:18:08.113943Z","end":"2026-05-14T10:18:08.600240Z","steps":["trace[911978594] 'process raft request' (duration: 485.96178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:08.599932Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:07.807996Z","time spent":"791.888588ms","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T10:18:08.600304Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:08.113916Z","time spent":"486.362066ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:08.600239Z","caller":"traceutil/trace.go:172","msg":"trace[298396751] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"755.380213ms","start":"2026-05-14T10:18:07.844770Z","end":"2026-05-14T10:18:08.600150Z","steps":["trace[298396751] 'process raft request' (duration: 755.019767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:08.600424Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"514.466692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:08.600548Z","caller":"traceutil/trace.go:172","msg":"trace[1850397869] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses; range_end:; response_count:0; response_revision:540; }","duration":"514.602284ms","start":"2026-05-14T10:18:08.085922Z","end":"2026-05-14T10:18:08.600524Z","steps":["trace[1850397869] 'agreement among raft nodes before linearized reading' (duration: 514.412791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:08.600606Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:08.085896Z","time spent":"514.695466ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:08.600703Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:07.844739Z","time spent":"755.702308ms","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:08.600815Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"272.373597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-14T10:18:08.602052Z","caller":"traceutil/trace.go:172","msg":"trace[321575281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:540; }","duration":"273.602825ms","start":"2026-05-14T10:18:08.328430Z","end":"2026-05-14T10:18:08.602033Z","steps":["trace[321575281] 'agreement among raft nodes before linearized reading' (duration: 272.261135ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:08.804024Z","caller":"traceutil/trace.go:172","msg":"trace[12511747] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:572; }","duration":"164.097152ms","start":"2026-05-14T10:18:08.639885Z","end":"2026-05-14T10:18:08.803982Z","steps":["trace[12511747] 'read index received' (duration: 164.078801ms)","trace[12511747] 'applied index is now lower than readState.Index' (duration: 15.381µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:08.829198Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"189.293324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-14T10:18:08.829271Z","caller":"traceutil/trace.go:172","msg":"trace[1828829512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:541; }","duration":"189.378516ms","start":"2026-05-14T10:18:08.639875Z","end":"2026-05-14T10:18:08.829253Z","steps":["trace[1828829512] 'agreement among raft nodes before linearized reading' (duration: 164.292994ms)","trace[1828829512] 'range keys from in-memory index tree' (duration: 24.832627ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:08.829354Z","caller":"traceutil/trace.go:172","msg":"trace[1328617378] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"196.427033ms","start":"2026-05-14T10:18:08.632901Z","end":"2026-05-14T10:18:08.829328Z","steps":["trace[1328617378] 'process raft request' (duration: 171.278741ms)","trace[1328617378] 'compare' (duration: 25.02726ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:08.850990Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"170.777433ms","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-14T10:18:08.851061Z","caller":"traceutil/trace.go:172","msg":"trace[1032062420] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:542; }","duration":"170.858875ms","start":"2026-05-14T10:18:08.680187Z","end":"2026-05-14T10:18:08.851046Z","steps":["trace[1032062420] 'agreement among raft nodes before linearized reading' (duration: 170.744473ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:08.851437Z","caller":"traceutil/trace.go:172","msg":"trace[2028704469] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"218.481187ms","start":"2026-05-14T10:18:08.632942Z","end":"2026-05-14T10:18:08.851423Z","steps":["trace[2028704469] 'process raft request' (duration: 218.171043ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:08.851412Z","caller":"traceutil/trace.go:172","msg":"trace[197259677] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"196.510604ms","start":"2026-05-14T10:18:08.654879Z","end":"2026-05-14T10:18:08.851390Z","steps":["trace[197259677] 'process raft request' (duration: 196.405712ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:08.963309Z","caller":"traceutil/trace.go:172","msg":"trace[1838769215] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:575; }","duration":"112.342766ms","start":"2026-05-14T10:18:08.850911Z","end":"2026-05-14T10:18:08.963254Z","steps":["trace[1838769215] 'read index received' (duration: 112.328295ms)","trace[1838769215] 'applied index is now lower than readState.Index' (duration: 9.44µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:09.008459Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"180.757774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:09.008547Z","caller":"traceutil/trace.go:172","msg":"trace[182104098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:544; }","duration":"180.857806ms","start":"2026-05-14T10:18:08.827673Z","end":"2026-05-14T10:18:09.008531Z","steps":["trace[182104098] 'agreement among raft nodes before linearized reading' (duration: 135.759261ms)","trace[182104098] 'range keys from in-memory index tree' (duration: 44.958702ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:09.008585Z","caller":"traceutil/trace.go:172","msg":"trace[933141457] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"164.266565ms","start":"2026-05-14T10:18:08.844303Z","end":"2026-05-14T10:18:09.008570Z","steps":["trace[933141457] 'process raft request' (duration: 164.195703ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:09.008673Z","caller":"traceutil/trace.go:172","msg":"trace[879150002] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"173.700788ms","start":"2026-05-14T10:18:08.834953Z","end":"2026-05-14T10:18:09.008654Z","steps":["trace[879150002] 'process raft request' (duration: 128.41984ms)","trace[879150002] 'compare' (duration: 45.024884ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:09.077979Z","caller":"traceutil/trace.go:172","msg":"trace[1188285954] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"205.065063ms","start":"2026-05-14T10:18:08.872898Z","end":"2026-05-14T10:18:09.077963Z","steps":["trace[1188285954] 'process raft request' (duration: 204.611157ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:09.078556Z","caller":"traceutil/trace.go:172","msg":"trace[1616692350] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"151.315957ms","start":"2026-05-14T10:18:08.927204Z","end":"2026-05-14T10:18:09.078520Z","steps":["trace[1616692350] 'process raft request' (duration: 151.236966ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:09.287148Z","caller":"traceutil/trace.go:172","msg":"trace[2071287204] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"181.327621ms","start":"2026-05-14T10:18:09.105801Z","end":"2026-05-14T10:18:09.287129Z","steps":["trace[2071287204] 'process raft request' (duration: 110.532897ms)","trace[2071287204] 'compare' (duration: 70.654062ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:09.344367Z","caller":"traceutil/trace.go:172","msg":"trace[262754725] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"220.11289ms","start":"2026-05-14T10:18:09.124234Z","end":"2026-05-14T10:18:09.344347Z","steps":["trace[262754725] 'process raft request' (duration: 220.037189ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:09.344878Z","caller":"traceutil/trace.go:172","msg":"trace[1319913283] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"228.120591ms","start":"2026-05-14T10:18:09.116742Z","end":"2026-05-14T10:18:09.344863Z","steps":["trace[1319913283] 'process raft request' (duration: 227.313839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:09.621163Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"179.671237ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:18:09.621272Z","caller":"traceutil/trace.go:172","msg":"trace[1635966167] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"245.448604ms","start":"2026-05-14T10:18:09.375807Z","end":"2026-05-14T10:18:09.621256Z","steps":["trace[1635966167] 'process raft request' (duration: 65.616515ms)","trace[1635966167] 'compare' (duration: 179.508204ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:09.698153Z","caller":"traceutil/trace.go:172","msg":"trace[151882455] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"290.706581ms","start":"2026-05-14T10:18:09.407429Z","end":"2026-05-14T10:18:09.698136Z","steps":["trace[151882455] 'process raft request' (duration: 290.573289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:10.232806Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"448.110026ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:18:10.232902Z","caller":"traceutil/trace.go:172","msg":"trace[944309390] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"655.738087ms","start":"2026-05-14T10:18:09.577148Z","end":"2026-05-14T10:18:10.232886Z","steps":["trace[944309390] 'process raft request' (duration: 207.497478ms)","trace[944309390] 'compare' (duration: 447.343525ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:10.232944Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:09.577119Z","time spent":"655.810448ms","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T10:18:10.329162Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330274,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-14T10:18:10.445036Z","caller":"traceutil/trace.go:172","msg":"trace[1633531687] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:587; }","duration":"616.57697ms","start":"2026-05-14T10:18:09.828444Z","end":"2026-05-14T10:18:10.445021Z","steps":["trace[1633531687] 'read index received' (duration: 616.57283ms)","trace[1633531687] 'applied index is now lower than readState.Index' (duration: 3.63µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:10.519971Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"691.497997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:10.520063Z","caller":"traceutil/trace.go:172","msg":"trace[581776760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"691.602758ms","start":"2026-05-14T10:18:09.828439Z","end":"2026-05-14T10:18:10.520042Z","steps":["trace[581776760] 'agreement among raft nodes before linearized reading' (duration: 616.647132ms)","trace[581776760] 'range keys from in-memory index tree' (duration: 74.766763ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:10.520105Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:09.828420Z","time spent":"691.677529ms","remote":"127.0.0.1:52770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-14T10:18:10.521051Z","caller":"traceutil/trace.go:172","msg":"trace[1163369732] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"814.432581ms","start":"2026-05-14T10:18:09.706596Z","end":"2026-05-14T10:18:10.521028Z","steps":["trace[1163369732] 'process raft request' (duration: 738.414849ms)","trace[1163369732] 'compare' (duration: 75.061738ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:10.521178Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:09.706573Z","time spent":"814.545723ms","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:10.521217Z","caller":"traceutil/trace.go:172","msg":"trace[373896401] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"796.626691ms","start":"2026-05-14T10:18:09.724573Z","end":"2026-05-14T10:18:10.521200Z","steps":["trace[373896401] 'process raft request' (duration: 796.336716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:10.521459Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:09.724556Z","time spent":"796.764884ms","remote":"127.0.0.1:52856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:10.521857Z","caller":"traceutil/trace.go:172","msg":"trace[2051444236] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"211.510896ms","start":"2026-05-14T10:18:10.310324Z","end":"2026-05-14T10:18:10.521835Z","steps":["trace[2051444236] 'process raft request' (duration: 211.325204ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:10.521924Z","caller":"traceutil/trace.go:172","msg":"trace[668349173] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"207.997944ms","start":"2026-05-14T10:18:10.313913Z","end":"2026-05-14T10:18:10.521911Z","steps":["trace[668349173] 'process raft request' (duration: 207.79539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:10.725385Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.653591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-14T10:18:10.725424Z","caller":"traceutil/trace.go:172","msg":"trace[672680848] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"152.140147ms","start":"2026-05-14T10:18:10.573256Z","end":"2026-05-14T10:18:10.725396Z","steps":["trace[672680848] 'process raft request' (duration: 145.025739ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:10.725455Z","caller":"traceutil/trace.go:172","msg":"trace[119242750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:561; }","duration":"101.737742ms","start":"2026-05-14T10:18:10.623704Z","end":"2026-05-14T10:18:10.725441Z","steps":["trace[119242750] 'agreement among raft nodes before linearized reading' (duration: 94.395011ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:10.742976Z","caller":"traceutil/trace.go:172","msg":"trace[642546718] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"133.22444ms","start":"2026-05-14T10:18:10.609729Z","end":"2026-05-14T10:18:10.742953Z","steps":["trace[642546718] 'process raft request' (duration: 132.940786ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:10.743099Z","caller":"traceutil/trace.go:172","msg":"trace[256662475] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"130.935825ms","start":"2026-05-14T10:18:10.612146Z","end":"2026-05-14T10:18:10.743082Z","steps":["trace[256662475] 'process raft request' (duration: 130.664631ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:10.743191Z","caller":"traceutil/trace.go:172","msg":"trace[188363158] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"122.879133ms","start":"2026-05-14T10:18:10.620302Z","end":"2026-05-14T10:18:10.743181Z","steps":["trace[188363158] 'process raft request' (duration: 122.613389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:11.301417Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"281.659027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" limit:1 ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-05-14T10:18:11.301610Z","caller":"traceutil/trace.go:172","msg":"trace[872487452] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:574; }","duration":"281.768439ms","start":"2026-05-14T10:18:11.019722Z","end":"2026-05-14T10:18:11.301490Z","steps":["trace[872487452] 'agreement among raft nodes before linearized reading' (duration: 134.990285ms)","trace[872487452] 'range keys from in-memory index tree' (duration: 146.52852ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:11.302537Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"147.724499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:18:11.302730Z","caller":"traceutil/trace.go:172","msg":"trace[2025914528] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"294.769366ms","start":"2026-05-14T10:18:11.007941Z","end":"2026-05-14T10:18:11.302710Z","steps":["trace[2025914528] 'process raft request' (duration: 146.813444ms)","trace[2025914528] 'compare' (duration: 147.335693ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:11.305313Z","caller":"traceutil/trace.go:172","msg":"trace[767787477] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"222.376309ms","start":"2026-05-14T10:18:11.082922Z","end":"2026-05-14T10:18:11.305298Z","steps":["trace[767787477] 'process raft request' (duration: 222.327638ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:11.305655Z","caller":"traceutil/trace.go:172","msg":"trace[283472174] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"235.435556ms","start":"2026-05-14T10:18:11.070207Z","end":"2026-05-14T10:18:11.305643Z","steps":["trace[283472174] 'process raft request' (duration: 234.964809ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:12.851172Z","caller":"traceutil/trace.go:172","msg":"trace[1157975001] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"101.70752ms","start":"2026-05-14T10:18:12.749440Z","end":"2026-05-14T10:18:12.851147Z","steps":["trace[1157975001] 'process raft request' (duration: 101.594648ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:12.853926Z","caller":"traceutil/trace.go:172","msg":"trace[1031656397] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"103.231323ms","start":"2026-05-14T10:18:12.750671Z","end":"2026-05-14T10:18:12.853902Z","steps":["trace[1031656397] 'process raft request' (duration: 103.115841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:15.985733Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"157.207634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:15.985878Z","caller":"traceutil/trace.go:172","msg":"trace[927754841] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"157.379577ms","start":"2026-05-14T10:18:15.828473Z","end":"2026-05-14T10:18:15.985853Z","steps":["trace[927754841] 'agreement among raft nodes before linearized reading' (duration: 23.087008ms)","trace[927754841] 'range keys from in-memory index tree' (duration: 134.055365ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:15.986664Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"134.958379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:18:15.987019Z","caller":"traceutil/trace.go:172","msg":"trace[209134419] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"196.914924ms","start":"2026-05-14T10:18:15.790062Z","end":"2026-05-14T10:18:15.986977Z","steps":["trace[209134419] 'process raft request' (duration: 61.562389ms)","trace[209134419] 'compare' (duration: 134.446021ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:15.987481Z","caller":"traceutil/trace.go:172","msg":"trace[301804630] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"196.149002ms","start":"2026-05-14T10:18:15.791315Z","end":"2026-05-14T10:18:15.987464Z","steps":["trace[301804630] 'process raft request' (duration: 195.748856ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:16.315995Z","caller":"traceutil/trace.go:172","msg":"trace[969736479] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"115.471282ms","start":"2026-05-14T10:18:16.200495Z","end":"2026-05-14T10:18:16.315967Z","steps":["trace[969736479] 'process raft request' (duration: 115.071876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:16.592784Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"183.915626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:16.592846Z","caller":"traceutil/trace.go:172","msg":"trace[1654763351] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:597; }","duration":"183.997957ms","start":"2026-05-14T10:18:16.408835Z","end":"2026-05-14T10:18:16.592833Z","steps":["trace[1654763351] 'range keys from in-memory index tree' (duration: 183.809304ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:16.593009Z","caller":"traceutil/trace.go:172","msg":"trace[1344462308] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"144.333578ms","start":"2026-05-14T10:18:16.448656Z","end":"2026-05-14T10:18:16.592989Z","steps":["trace[1344462308] 'process raft request' (duration: 144.205736ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:17.166652Z","caller":"traceutil/trace.go:172","msg":"trace[199493205] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"228.207632ms","start":"2026-05-14T10:18:16.938409Z","end":"2026-05-14T10:18:17.166617Z","steps":["trace[199493205] 'process raft request' (duration: 183.158923ms)","trace[199493205] 'compare' (duration: 44.013104ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:17.174280Z","caller":"traceutil/trace.go:172","msg":"trace[393577817] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"181.843362ms","start":"2026-05-14T10:18:16.992409Z","end":"2026-05-14T10:18:17.174252Z","steps":["trace[393577817] 'process raft request' (duration: 173.583478ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:17.196998Z","caller":"traceutil/trace.go:172","msg":"trace[1603946668] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"181.69586ms","start":"2026-05-14T10:18:17.015286Z","end":"2026-05-14T10:18:17.196982Z","steps":["trace[1603946668] 'process raft request' (duration: 181.612429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:17.449559Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"179.188633ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:18:17.449729Z","caller":"traceutil/trace.go:172","msg":"trace[1244443972] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"214.634217ms","start":"2026-05-14T10:18:17.235063Z","end":"2026-05-14T10:18:17.449697Z","steps":["trace[1244443972] 'process raft request' (duration: 35.260881ms)","trace[1244443972] 'compare' (duration: 179.060951ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:19.181039Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330413,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T10:18:19.682190Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330413,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T10:18:19.707912Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.223877388s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T10:18:19.708247Z","caller":"traceutil/trace.go:172","msg":"trace[1089726404] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:642; }","duration":"1.027952834s","start":"2026-05-14T10:18:18.680142Z","end":"2026-05-14T10:18:19.708095Z","steps":["trace[1089726404] 'read index received' (duration: 1.027940844s)","trace[1089726404] 'applied index is now lower than readState.Index' (duration: 10.29µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:19.708371Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.028200158s","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-14T10:18:19.708457Z","caller":"traceutil/trace.go:172","msg":"trace[858763577] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:609; }","duration":"1.02830428s","start":"2026-05-14T10:18:18.680135Z","end":"2026-05-14T10:18:19.708439Z","steps":["trace[858763577] 'agreement among raft nodes before linearized reading' (duration: 1.028156857s)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:19.711638Z","caller":"traceutil/trace.go:172","msg":"trace[463023521] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"1.23464779s","start":"2026-05-14T10:18:18.476975Z","end":"2026-05-14T10:18:19.711623Z","steps":["trace[463023521] 'process raft request' (duration: 1.232542148s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:19.711748Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:18.476943Z","time spent":"1.234748912s","remote":"127.0.0.1:52918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036201,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:20.829208Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.62799673s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-14T10:18:20.829274Z","caller":"traceutil/trace.go:172","msg":"trace[2124036735] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:610; }","duration":"1.628074651s","start":"2026-05-14T10:18:19.201184Z","end":"2026-05-14T10:18:20.829259Z","steps":["trace[2124036735] 'agreement among raft nodes before linearized reading' (duration: 573.165772ms)","trace[2124036735] 'range keys from in-memory index tree' (duration: 1.054769297s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:20.829292Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.54896412s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tw27p\" limit:1 ","response":"range_response_count:1 size:18345"} {"level":"warn","ts":"2026-05-14T10:18:20.829208Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.354337028s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-14T10:18:20.829323Z","caller":"traceutil/trace.go:172","msg":"trace[850826456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"1.35446807s","start":"2026-05-14T10:18:19.474847Z","end":"2026-05-14T10:18:20.829315Z","steps":["trace[850826456] 'agreement among raft nodes before linearized reading' (duration: 299.48269ms)","trace[850826456] 'range keys from in-memory index tree' (duration: 1.054742117s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:20.829337Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:19.474821Z","time spent":"1.354512261s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-05-14T10:18:20.829332Z","caller":"traceutil/trace.go:172","msg":"trace[1803373010] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tw27p; range_end:; response_count:1; response_revision:610; }","duration":"1.54899685s","start":"2026-05-14T10:18:19.280320Z","end":"2026-05-14T10:18:20.829317Z","steps":["trace[1803373010] 'agreement among raft nodes before linearized reading' (duration: 494.012ms)","trace[1803373010] 'range keys from in-memory index tree' (duration: 1.054899799s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:20.829360Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:19.280300Z","time spent":"1.549052742s","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18368,"request content":"key:\"/registry/pods/kube-system/cilium-tw27p\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:20.829302Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:19.201164Z","time spent":"1.628132502s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:20.829631Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.055122832s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:18:20.829986Z","caller":"traceutil/trace.go:172","msg":"trace[556346423] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"211.785518ms","start":"2026-05-14T10:18:20.618182Z","end":"2026-05-14T10:18:20.829967Z","steps":["trace[556346423] 'process raft request' (duration: 211.730797ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:20.830240Z","caller":"traceutil/trace.go:172","msg":"trace[1822986784] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.81455811s","start":"2026-05-14T10:18:19.015664Z","end":"2026-05-14T10:18:20.830223Z","steps":["trace[1822986784] 'process raft request' (duration: 758.750517ms)","trace[1822986784] 'compare' (duration: 1.054641955s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:20.830327Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:19.015645Z","time spent":"1.814639791s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:20.830410Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.120828151s","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-14T10:18:20.830451Z","caller":"traceutil/trace.go:172","msg":"trace[1936719256] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:614; }","duration":"1.120870702s","start":"2026-05-14T10:18:19.709570Z","end":"2026-05-14T10:18:20.830441Z","steps":["trace[1936719256] 'agreement among raft nodes before linearized reading' (duration: 1.120806511s)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:20.830494Z","caller":"traceutil/trace.go:172","msg":"trace[803178587] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.038205727s","start":"2026-05-14T10:18:19.792255Z","end":"2026-05-14T10:18:20.830461Z","steps":["trace[803178587] 'process raft request' (duration: 1.037607278s)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:20.830348Z","caller":"traceutil/trace.go:172","msg":"trace[767229150] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:643; }","duration":"1.056020796s","start":"2026-05-14T10:18:19.774312Z","end":"2026-05-14T10:18:20.830333Z","steps":["trace[767229150] 'read index received' (duration: 15.311µs)","trace[767229150] 'applied index is now lower than readState.Index' (duration: 1.056003325s)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:20.830670Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:19.792232Z","time spent":"1.038289698s","remote":"127.0.0.1:53364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T10:18:20.830762Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.003365983s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:20.830774Z","caller":"traceutil/trace.go:172","msg":"trace[238888371] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.658646822s","start":"2026-05-14T10:18:19.172108Z","end":"2026-05-14T10:18:20.830755Z","steps":["trace[238888371] 'process raft request' (duration: 1.657642887s)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:20.830808Z","caller":"traceutil/trace.go:172","msg":"trace[378703673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"1.003409953s","start":"2026-05-14T10:18:19.827385Z","end":"2026-05-14T10:18:20.830795Z","steps":["trace[378703673] 'agreement among raft nodes before linearized reading' (duration: 1.003338112s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:20.830843Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:19.827367Z","time spent":"1.003468044s","remote":"127.0.0.1:52752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T10:18:20.830860Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:19.172077Z","time spent":"1.658735644s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:20.830997Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.099766394s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:20.831040Z","caller":"traceutil/trace.go:172","msg":"trace[724444894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"1.099806415s","start":"2026-05-14T10:18:19.731222Z","end":"2026-05-14T10:18:20.831028Z","steps":["trace[724444894] 'agreement among raft nodes before linearized reading' (duration: 1.099744354s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:20.831067Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:19.731202Z","time spent":"1.099858496s","remote":"127.0.0.1:52770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T10:18:20.831139Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"367.112715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.27\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-14T10:18:20.831181Z","caller":"traceutil/trace.go:172","msg":"trace[376630396] range","detail":"{range_begin:/registry/masterleases/199.19.213.27; range_end:; response_count:1; response_revision:614; }","duration":"367.155756ms","start":"2026-05-14T10:18:20.464013Z","end":"2026-05-14T10:18:20.831169Z","steps":["trace[376630396] 'agreement among raft nodes before linearized reading' (duration: 367.024414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:20.831213Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:20.463993Z","time spent":"367.210926ms","remote":"127.0.0.1:52808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.27\" limit:1 "} {"level":"info","ts":"2026-05-14T10:18:20.998656Z","caller":"traceutil/trace.go:172","msg":"trace[661913909] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:648; }","duration":"134.651496ms","start":"2026-05-14T10:18:20.863972Z","end":"2026-05-14T10:18:20.998623Z","steps":["trace[661913909] 'read index received' (duration: 134.641576ms)","trace[661913909] 'applied index is now lower than readState.Index' (duration: 8.58µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:21.197416Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"354.576065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:21.197507Z","caller":"traceutil/trace.go:172","msg":"trace[2023491471] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:614; }","duration":"354.672026ms","start":"2026-05-14T10:18:20.842806Z","end":"2026-05-14T10:18:21.197478Z","steps":["trace[2023491471] 'agreement among raft nodes before linearized reading' (duration: 155.952577ms)","trace[2023491471] 'range keys from in-memory index tree' (duration: 198.590127ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:21.197554Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:20.842788Z","time spent":"354.753127ms","remote":"127.0.0.1:53374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:21.197781Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"198.876021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:18:21.198239Z","caller":"traceutil/trace.go:172","msg":"trace[1165752847] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"333.131712ms","start":"2026-05-14T10:18:20.865090Z","end":"2026-05-14T10:18:21.198222Z","steps":["trace[1165752847] 'process raft request' (duration: 333.085362ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:21.198301Z","caller":"traceutil/trace.go:172","msg":"trace[554153951] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"347.042001ms","start":"2026-05-14T10:18:20.851222Z","end":"2026-05-14T10:18:21.198264Z","steps":["trace[554153951] 'process raft request' (duration: 346.883979ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:21.198323Z","caller":"traceutil/trace.go:172","msg":"trace[1877766900] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:648; }","duration":"199.567882ms","start":"2026-05-14T10:18:20.998733Z","end":"2026-05-14T10:18:21.198301Z","steps":["trace[1877766900] 'read index received' (duration: 19.876329ms)","trace[1877766900] 'applied index is now lower than readState.Index' (duration: 179.688683ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:21.198336Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:20.864978Z","time spent":"333.314324ms","remote":"127.0.0.1:52808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:21.198325Z","caller":"traceutil/trace.go:172","msg":"trace[1505294684] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"358.446423ms","start":"2026-05-14T10:18:20.839862Z","end":"2026-05-14T10:18:21.198308Z","steps":["trace[1505294684] 'process raft request' (duration: 358.025356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:21.198420Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"333.331945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T10:18:21.198428Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:20.851199Z","time spent":"347.158003ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18502,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:21.198480Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:20.839854Z","time spent":"358.549245ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:21.198458Z","caller":"traceutil/trace.go:172","msg":"trace[1922143111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"333.371016ms","start":"2026-05-14T10:18:20.865075Z","end":"2026-05-14T10:18:21.198446Z","steps":["trace[1922143111] 'agreement among raft nodes before linearized reading' (duration: 333.297275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:21.199567Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:20.865065Z","time spent":"334.485022ms","remote":"127.0.0.1:52752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-14T10:18:21.199330Z","caller":"traceutil/trace.go:172","msg":"trace[124960810] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"359.203544ms","start":"2026-05-14T10:18:20.838811Z","end":"2026-05-14T10:18:21.198014Z","steps":["trace[124960810] 'process raft request' (duration: 159.996648ms)","trace[124960810] 'compare' (duration: 198.75689ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:21.200442Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:20.838791Z","time spent":"360.981092ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":424,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:23.326302Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330435,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T10:18:23.827105Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330435,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T10:18:23.873718Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"130.231306ms","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-14T10:18:23.873988Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.194201322s","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-14T10:18:23.874064Z","caller":"traceutil/trace.go:172","msg":"trace[1012664126] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:618; }","duration":"2.194287773s","start":"2026-05-14T10:18:21.679761Z","end":"2026-05-14T10:18:23.874049Z","steps":["trace[1012664126] 'range keys from in-memory index tree' (duration: 2.194162862s)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:23.874440Z","caller":"traceutil/trace.go:172","msg":"trace[118276013] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:618; }","duration":"130.311377ms","start":"2026-05-14T10:18:23.743464Z","end":"2026-05-14T10:18:23.873776Z","steps":["trace[118276013] 'range keys from in-memory index tree' (duration: 130.182866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:23.886370Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.280172545s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T10:18:23.886610Z","caller":"traceutil/trace.go:172","msg":"trace[994480503] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:652; }","duration":"1.061113629s","start":"2026-05-14T10:18:22.825470Z","end":"2026-05-14T10:18:23.886584Z","steps":["trace[994480503] 'read index received' (duration: 1.061100709s)","trace[994480503] 'applied index is now lower than readState.Index' (duration: 10.88µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:23.886757Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.061275472s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:23.886808Z","caller":"traceutil/trace.go:172","msg":"trace[98580729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"1.061328252s","start":"2026-05-14T10:18:22.825466Z","end":"2026-05-14T10:18:23.886794Z","steps":["trace[98580729] 'agreement among raft nodes before linearized reading' (duration: 1.061240631s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:23.886878Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:22.825445Z","time spent":"1.061423505s","remote":"127.0.0.1:52770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-14T10:18:23.887486Z","caller":"traceutil/trace.go:172","msg":"trace[1988609537] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"2.282319876s","start":"2026-05-14T10:18:21.605141Z","end":"2026-05-14T10:18:23.887461Z","steps":["trace[1988609537] 'process raft request' (duration: 2.281634436s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:23.887637Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:21.605117Z","time spent":"2.282448609s","remote":"127.0.0.1:52918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036233,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:23.924997Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"714.157097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-14T10:18:23.925054Z","caller":"traceutil/trace.go:172","msg":"trace[55959986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"714.218508ms","start":"2026-05-14T10:18:23.210819Z","end":"2026-05-14T10:18:23.925038Z","steps":["trace[55959986] 'agreement among raft nodes before linearized reading' (duration: 714.072356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:23.925080Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:23.210787Z","time spent":"714.285208ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:23.924997Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"714.727845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-14T10:18:23.925127Z","caller":"traceutil/trace.go:172","msg":"trace[1690311172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"714.869627ms","start":"2026-05-14T10:18:23.210249Z","end":"2026-05-14T10:18:23.925119Z","steps":["trace[1690311172] 'agreement among raft nodes before linearized reading' (duration: 714.636354ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:23.925149Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:23.210232Z","time spent":"714.910848ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-05-14T10:18:23.925225Z","caller":"traceutil/trace.go:172","msg":"trace[1373615128] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.089532287s","start":"2026-05-14T10:18:22.835682Z","end":"2026-05-14T10:18:23.925214Z","steps":["trace[1373615128] 'process raft request' (duration: 1.089295943s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:23.925284Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:22.835665Z","time spent":"1.089582957s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:23.925714Z","caller":"traceutil/trace.go:172","msg":"trace[667686470] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"1.087911022s","start":"2026-05-14T10:18:22.837377Z","end":"2026-05-14T10:18:23.925288Z","steps":["trace[667686470] 'process raft request' (duration: 1.087734639s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:23.927252Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:22.837367Z","time spent":"1.089825371s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:26.212228Z","caller":"traceutil/trace.go:172","msg":"trace[799040901] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:671; }","duration":"385.539581ms","start":"2026-05-14T10:18:25.826657Z","end":"2026-05-14T10:18:26.212197Z","steps":["trace[799040901] 'read index received' (duration: 385.525561ms)","trace[799040901] 'applied index is now lower than readState.Index' (duration: 12.46µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:26.217535Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"537.103695ms","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-14T10:18:26.217631Z","caller":"traceutil/trace.go:172","msg":"trace[169710588] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:637; }","duration":"537.208216ms","start":"2026-05-14T10:18:25.680404Z","end":"2026-05-14T10:18:26.217613Z","steps":["trace[169710588] 'range keys from in-memory index tree' (duration: 537.053355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:26.217712Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"391.058865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:26.217867Z","caller":"traceutil/trace.go:172","msg":"trace[1503633214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"391.167246ms","start":"2026-05-14T10:18:25.826636Z","end":"2026-05-14T10:18:26.217803Z","steps":["trace[1503633214] 'agreement among raft nodes before linearized reading' (duration: 385.727435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:26.218165Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:25.826613Z","time spent":"391.294648ms","remote":"127.0.0.1:52770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-14T10:18:26.218597Z","caller":"traceutil/trace.go:172","msg":"trace[221209958] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"699.652294ms","start":"2026-05-14T10:18:25.518911Z","end":"2026-05-14T10:18:26.218563Z","steps":["trace[221209958] 'process raft request' (duration: 693.249268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:26.218742Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:25.518891Z","time spent":"699.788975ms","remote":"127.0.0.1:53142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2676,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T10:18:26.218812Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"278.698259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-14T10:18:26.218845Z","caller":"traceutil/trace.go:172","msg":"trace[928512940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"278.73384ms","start":"2026-05-14T10:18:25.940103Z","end":"2026-05-14T10:18:26.218837Z","steps":["trace[928512940] 'agreement among raft nodes before linearized reading' (duration: 278.586508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:26.219126Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"280.440925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-14T10:18:26.219171Z","caller":"traceutil/trace.go:172","msg":"trace[450405205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"280.491956ms","start":"2026-05-14T10:18:25.938666Z","end":"2026-05-14T10:18:26.219158Z","steps":["trace[450405205] 'agreement among raft nodes before linearized reading' (duration: 280.311773ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:26.219291Z","caller":"traceutil/trace.go:172","msg":"trace[269483614] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"289.669723ms","start":"2026-05-14T10:18:25.929610Z","end":"2026-05-14T10:18:26.219280Z","steps":["trace[269483614] 'process raft request' (duration: 288.979003ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:26.219465Z","caller":"traceutil/trace.go:172","msg":"trace[89324680] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"287.843026ms","start":"2026-05-14T10:18:25.931600Z","end":"2026-05-14T10:18:26.219443Z","steps":["trace[89324680] 'process raft request' (duration: 287.268027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:34.030427Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55224","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:35.924104Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50002","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:35.935025Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50010","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:36.035053Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50014","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:36.064104Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50038","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:36.224410Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50054","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:37.497029Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50076","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:38.638855Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50110","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:38.658647Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50130","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:38.700214Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50152","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:38.738060Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50172","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:38.869070Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50188","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:38.893722Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50212","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:38.915122Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50236","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:38.932356Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50256","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:38.964197Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50272","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:38.987339Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50282","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.019139Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50290","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.058053Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50318","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.099516Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50338","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.144058Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50348","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.177786Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50358","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.192778Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50398","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.213022Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50410","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.363521Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50428","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.439872Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50442","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.498770Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50460","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.520339Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50468","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.528828Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50482","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.543669Z","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-14T10:18:39.559176Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50504","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:39.573820Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50524","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-14T10:18:40.476350Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.432588ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T10:18:40.476604Z","caller":"traceutil/trace.go:172","msg":"trace[480892570] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"134.042144ms","start":"2026-05-14T10:18:40.342540Z","end":"2026-05-14T10:18:40.476582Z","steps":["trace[480892570] 'process raft request' (duration: 133.915632ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:40.476608Z","caller":"traceutil/trace.go:172","msg":"trace[892106034] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"136.124405ms","start":"2026-05-14T10:18:40.340466Z","end":"2026-05-14T10:18:40.476591Z","steps":["trace[892106034] 'process raft request' (duration: 26.381743ms)","trace[892106034] 'compare' (duration: 109.331566ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:40.624361Z","caller":"traceutil/trace.go:172","msg":"trace[1271769039] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"130.258177ms","start":"2026-05-14T10:18:40.494086Z","end":"2026-05-14T10:18:40.624344Z","steps":["trace[1271769039] 'process raft request' (duration: 130.157515ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:40.624604Z","caller":"traceutil/trace.go:172","msg":"trace[1382361011] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"139.655986ms","start":"2026-05-14T10:18:40.484937Z","end":"2026-05-14T10:18:40.624593Z","steps":["trace[1382361011] 'process raft request' (duration: 138.996927ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:40.946541Z","caller":"traceutil/trace.go:172","msg":"trace[161612135] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"206.534112ms","start":"2026-05-14T10:18:40.739985Z","end":"2026-05-14T10:18:40.946519Z","steps":["trace[161612135] 'process raft request' (duration: 124.331329ms)","trace[161612135] 'compare' (duration: 82.116712ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:40.946723Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"150.029712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/coredns-7488bc8bd5-vj9m2.18af6741d2b67895\" limit:1 ","response":"range_response_count:1 size:860"} {"level":"info","ts":"2026-05-14T10:18:40.946798Z","caller":"traceutil/trace.go:172","msg":"trace[1637821922] range","detail":"{range_begin:/registry/events/kube-system/coredns-7488bc8bd5-vj9m2.18af6741d2b67895; range_end:; response_count:1; response_revision:785; }","duration":"150.120493ms","start":"2026-05-14T10:18:40.796657Z","end":"2026-05-14T10:18:40.946778Z","steps":["trace[1637821922] 'agreement among raft nodes before linearized reading' (duration: 67.576745ms)","trace[1637821922] 'range keys from in-memory index tree' (duration: 82.135292ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:40.966337Z","caller":"traceutil/trace.go:172","msg":"trace[1075854272] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:826; }","duration":"102.099149ms","start":"2026-05-14T10:18:40.864209Z","end":"2026-05-14T10:18:40.966308Z","steps":["trace[1075854272] 'read index received' (duration: 102.091649ms)","trace[1075854272] 'applied index is now lower than readState.Index' (duration: 6.24µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:40.966597Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"139.410044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:40.966772Z","caller":"traceutil/trace.go:172","msg":"trace[777455932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:786; }","duration":"139.593836ms","start":"2026-05-14T10:18:40.827159Z","end":"2026-05-14T10:18:40.966753Z","steps":["trace[777455932] 'agreement among raft nodes before linearized reading' (duration: 139.363743ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:40.967148Z","caller":"traceutil/trace.go:172","msg":"trace[1163081731] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"169.857407ms","start":"2026-05-14T10:18:40.797259Z","end":"2026-05-14T10:18:40.967117Z","steps":["trace[1163081731] 'process raft request' (duration: 169.461991ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:40.967172Z","caller":"traceutil/trace.go:172","msg":"trace[197481050] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"166.322614ms","start":"2026-05-14T10:18:40.800826Z","end":"2026-05-14T10:18:40.967148Z","steps":["trace[197481050] 'process raft request' (duration: 166.264403ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:40.967421Z","caller":"traceutil/trace.go:172","msg":"trace[1267464192] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"166.973244ms","start":"2026-05-14T10:18:40.800434Z","end":"2026-05-14T10:18:40.967407Z","steps":["trace[1267464192] 'process raft request' (duration: 166.583688ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:42.586003Z","caller":"traceutil/trace.go:172","msg":"trace[908984423] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:837; }","duration":"104.587504ms","start":"2026-05-14T10:18:42.481385Z","end":"2026-05-14T10:18:42.585972Z","steps":["trace[908984423] 'read index received' (duration: 104.579844ms)","trace[908984423] 'applied index is now lower than readState.Index' (duration: 6.63µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:18:42.586270Z","caller":"traceutil/trace.go:172","msg":"trace[242152236] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"116.887187ms","start":"2026-05-14T10:18:42.469351Z","end":"2026-05-14T10:18:42.586238Z","steps":["trace[242152236] 'process raft request' (duration: 116.685684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:42.586341Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"104.92648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-14T10:18:42.586394Z","caller":"traceutil/trace.go:172","msg":"trace[240598429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:797; }","duration":"105.002871ms","start":"2026-05-14T10:18:42.481381Z","end":"2026-05-14T10:18:42.586384Z","steps":["trace[240598429] 'agreement among raft nodes before linearized reading' (duration: 104.726777ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:42.586336Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"104.918909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-14T10:18:42.586512Z","caller":"traceutil/trace.go:172","msg":"trace[166533697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"105.114652ms","start":"2026-05-14T10:18:42.481385Z","end":"2026-05-14T10:18:42.586500Z","steps":["trace[166533697] 'agreement among raft nodes before linearized reading' (duration: 104.792287ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:47.858556Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330954,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T10:18:48.358872Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330954,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T10:18:48.698237Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.418603806s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T10:18:48.698440Z","caller":"traceutil/trace.go:172","msg":"trace[86670308] linearizableReadLoop","detail":"{readStateIndex:868; appliedIndex:868; }","duration":"1.340541499s","start":"2026-05-14T10:18:47.357871Z","end":"2026-05-14T10:18:48.698413Z","steps":["trace[86670308] 'read index received' (duration: 1.340531659s)","trace[86670308] 'applied index is now lower than readState.Index' (duration: 8.42µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:48.698575Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.340684911s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:48.698627Z","caller":"traceutil/trace.go:172","msg":"trace[1702379254] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"1.419109053s","start":"2026-05-14T10:18:47.279508Z","end":"2026-05-14T10:18:48.698617Z","steps":["trace[1702379254] 'process raft request' (duration: 1.418936861s)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:48.698648Z","caller":"traceutil/trace.go:172","msg":"trace[1099374058] range","detail":"{range_begin:/registry/leases; range_end:; response_count:0; response_revision:827; }","duration":"1.340766482s","start":"2026-05-14T10:18:47.357866Z","end":"2026-05-14T10:18:48.698632Z","steps":["trace[1099374058] 'agreement among raft nodes before linearized reading' (duration: 1.34063005s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:48.698683Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:47.357845Z","time spent":"1.340832003s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":20,"response count":0,"response size":28,"request content":"key:\"/registry/leases\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:48.698711Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:47.279479Z","time spent":"1.419175444s","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":478,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:49.199297Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8544065329083330959,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-14T10:18:49.286406Z","caller":"traceutil/trace.go:172","msg":"trace[725048527] linearizableReadLoop","detail":"{readStateIndex:869; appliedIndex:869; }","duration":"587.87689ms","start":"2026-05-14T10:18:48.698495Z","end":"2026-05-14T10:18:49.286372Z","steps":["trace[725048527] 'read index received' (duration: 587.87009ms)","trace[725048527] 'applied index is now lower than readState.Index' (duration: 6.08µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T10:18:49.287077Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.587682877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:49.287258Z","caller":"traceutil/trace.go:172","msg":"trace[1761408932] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices; range_end:; response_count:0; response_revision:828; }","duration":"1.58787118s","start":"2026-05-14T10:18:47.699248Z","end":"2026-05-14T10:18:49.287119Z","steps":["trace[1761408932] 'agreement among raft nodes before linearized reading' (duration: 1.587656707s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:49.287449Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:47.699219Z","time spent":"1.588213804s","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:49.287656Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.263742945s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T10:18:49.287689Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"645.691496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-14T10:18:49.287791Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.707911669s","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-14T10:18:49.287831Z","caller":"traceutil/trace.go:172","msg":"trace[279475514] range","detail":"{range_begin:/registry/deployments; range_end:; response_count:0; response_revision:828; }","duration":"1.707952289s","start":"2026-05-14T10:18:47.579868Z","end":"2026-05-14T10:18:49.287821Z","steps":["trace[279475514] 'agreement among raft nodes before linearized reading' (duration: 1.707892208s)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:49.287792Z","caller":"traceutil/trace.go:172","msg":"trace[643656594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:828; }","duration":"645.787458ms","start":"2026-05-14T10:18:48.641988Z","end":"2026-05-14T10:18:49.287776Z","steps":["trace[643656594] 'agreement among raft nodes before linearized reading' (duration: 645.607265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:49.287864Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:47.579849Z","time spent":"1.708005831s","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":28,"request content":"key:\"/registry/deployments\" limit:1 "} {"level":"info","ts":"2026-05-14T10:18:49.287713Z","caller":"traceutil/trace.go:172","msg":"trace[1055247484] range","detail":"{range_begin:/registry/horizontalpodautoscalers; range_end:; response_count:0; response_revision:828; }","duration":"1.263801345s","start":"2026-05-14T10:18:48.023897Z","end":"2026-05-14T10:18:49.287699Z","steps":["trace[1055247484] 'agreement among raft nodes before linearized reading' (duration: 1.263711204s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:49.287528Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"652.030891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-14T10:18:49.287951Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.607574141s","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-14T10:18:49.287997Z","caller":"traceutil/trace.go:172","msg":"trace[1196999908] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:828; }","duration":"1.607619762s","start":"2026-05-14T10:18:47.680363Z","end":"2026-05-14T10:18:49.287983Z","steps":["trace[1196999908] 'agreement among raft nodes before linearized reading' (duration: 1.607555191s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:49.288028Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:48.023881Z","time spent":"1.264051929s","remote":"127.0.0.1:53132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:49.288122Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"597.945789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:78 size:6790"} {"level":"info","ts":"2026-05-14T10:18:49.288006Z","caller":"traceutil/trace.go:172","msg":"trace[459869179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:828; }","duration":"652.508808ms","start":"2026-05-14T10:18:48.635474Z","end":"2026-05-14T10:18:49.287982Z","steps":["trace[459869179] 'agreement among raft nodes before linearized reading' (duration: 651.790187ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:49.288230Z","caller":"traceutil/trace.go:172","msg":"trace[1746079091] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:78; response_revision:828; }","duration":"598.153622ms","start":"2026-05-14T10:18:48.690005Z","end":"2026-05-14T10:18:49.288158Z","steps":["trace[1746079091] 'agreement among raft nodes before linearized reading' (duration: 596.504138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:49.288244Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.810179005s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:49.288272Z","caller":"traceutil/trace.go:172","msg":"trace[1245759565] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:828; }","duration":"1.810207066s","start":"2026-05-14T10:18:47.478056Z","end":"2026-05-14T10:18:49.288263Z","steps":["trace[1245759565] 'agreement among raft nodes before linearized reading' (duration: 1.810162875s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:49.288277Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:48.635456Z","time spent":"652.788221ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:49.288551Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"459.949343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:49.288607Z","caller":"traceutil/trace.go:172","msg":"trace[15187135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:831; }","duration":"460.044715ms","start":"2026-05-14T10:18:48.828549Z","end":"2026-05-14T10:18:49.288594Z","steps":["trace[15187135] 'agreement among raft nodes before linearized reading' (duration: 459.927293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:49.288651Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:48.828528Z","time spent":"460.112016ms","remote":"127.0.0.1:52770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T10:18:49.287876Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:48.641969Z","time spent":"645.897139ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:49.288303Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:47.478031Z","time spent":"1.810264926s","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/pods\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:49.288317Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:48.689979Z","time spent":"598.283664ms","remote":"127.0.0.1:52892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":78,"response size":6813,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true "} {"level":"info","ts":"2026-05-14T10:18:49.289032Z","caller":"traceutil/trace.go:172","msg":"trace[229295556] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"933.844956ms","start":"2026-05-14T10:18:48.355172Z","end":"2026-05-14T10:18:49.289017Z","steps":["trace[229295556] 'process raft request' (duration: 933.196666ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:49.289140Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:48.355110Z","time spent":"933.968678ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:49.289533Z","caller":"traceutil/trace.go:172","msg":"trace[424716478] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"929.856047ms","start":"2026-05-14T10:18:48.359659Z","end":"2026-05-14T10:18:49.289515Z","steps":["trace[424716478] 'process raft request' (duration: 928.763551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:49.290080Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"458.543322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deviceclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T10:18:49.288460Z","caller":"traceutil/trace.go:172","msg":"trace[2067400049] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"1.794559403s","start":"2026-05-14T10:18:47.493882Z","end":"2026-05-14T10:18:49.288441Z","steps":["trace[2067400049] 'process raft request' (duration: 1.794374391s)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:49.290128Z","caller":"traceutil/trace.go:172","msg":"trace[293217312] range","detail":"{range_begin:/registry/deviceclasses; range_end:; response_count:0; response_revision:831; }","duration":"458.591813ms","start":"2026-05-14T10:18:48.831526Z","end":"2026-05-14T10:18:49.290117Z","steps":["trace[293217312] 'agreement among raft nodes before linearized reading' (duration: 458.514802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T10:18:49.290374Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:48.831504Z","time spent":"458.857878ms","remote":"127.0.0.1:53784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":27,"response count":0,"response size":28,"request content":"key:\"/registry/deviceclasses\" limit:1 "} {"level":"warn","ts":"2026-05-14T10:18:49.290403Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:47.493813Z","time spent":"1.796542463s","remote":"127.0.0.1:53142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2879,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T10:18:49.291625Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-14T10:18:48.359643Z","time spent":"930.125491ms","remote":"127.0.0.1:53202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T10:18:49.413812Z","caller":"traceutil/trace.go:172","msg":"trace[1882328431] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"119.047713ms","start":"2026-05-14T10:18:49.294740Z","end":"2026-05-14T10:18:49.413788Z","steps":["trace[1882328431] 'process raft request' (duration: 118.029728ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:49.416832Z","caller":"traceutil/trace.go:172","msg":"trace[85413660] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"108.069241ms","start":"2026-05-14T10:18:49.308741Z","end":"2026-05-14T10:18:49.416810Z","steps":["trace[85413660] 'process raft request' (duration: 107.927399ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:18:51.989760Z","caller":"traceutil/trace.go:172","msg":"trace[788227601] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"129.806091ms","start":"2026-05-14T10:18:51.859933Z","end":"2026-05-14T10:18:51.989739Z","steps":["trace[788227601] 'process raft request' (duration: 64.959292ms)","trace[788227601] 'compare' (duration: 64.436213ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T10:19:51.707923Z","caller":"traceutil/trace.go:172","msg":"trace[372344372] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"104.962508ms","start":"2026-05-14T10:19:51.602940Z","end":"2026-05-14T10:19:51.707903Z","steps":["trace[372344372] 'process raft request' (duration: 104.838746ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T10:19:51.712654Z","caller":"traceutil/trace.go:172","msg":"trace[478218897] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"102.253898ms","start":"2026-05-14T10:19:51.610386Z","end":"2026-05-14T10:19:51.712640Z","steps":["trace[478218897] 'process raft request' (duration: 102.180607ms)"],"step_count":1}