{"level":"warn","ts":"2026-04-18T17:51:11.320274Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-04-18T17:51:11.320792Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-04-18T17:51:11.320804Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.204.45.109:2380","--initial-cluster=controller=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-04-18T17:51:11.320867Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-04-18T17:51:11.320882Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T17:51:11.320893Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-04-18T17:51:11.320917Z","caller":"embed/etcd.go:544","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-18T17:51:11.321298Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-04-18T17:51:11.321395Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.204.45.109: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-04-18T17:51:11.321963Z","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: 0xc0000781b8}"} {"level":"info","ts":"2026-04-18T17:51:11.326833Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-04-18T17:51:11.326889Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.010636ms"} {"level":"info","ts":"2026-04-18T17:51:11.326938Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-04-18T17:51:11.326958Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-04-18T17:51:11.326995Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-04-18T17:51:11.335133Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-04-18T17:51:11.335251Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-04-18T17:51:11.335284Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-04-18T17:51:11.335371Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T17:51:11.335417Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-04-18T17:51:11.335427Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T17:51:11.335439Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-04-18T17:51:11.335476Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-04-18T17:51:11.347477Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T17:51:11.351799Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T17:51:11.353738Z","caller":"storage/quota.go:93","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-18T17:51:11.354374Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T17:51:11.354477Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T17:51:11.354601Z","caller":"embed/etcd.go:766","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-18T17:51:11.354648Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T17:51:11.354721Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T17:51:11.354737Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T17:51:11.354735Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-04-18T17:51:11.354759Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-04-18T17:51:11.354887Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T17:51:11.355273Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T17:51:11.355302Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-04-18T17:51:11.355417Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-04-18T17:51:11.536569Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T17:51:11.536633Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T17:51:11.536693Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-04-18T17:51:11.536715Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"d71a1778b31d4ce has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-18T17:51:11.536737Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-04-18T17:51:11.539021Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-04-18T17:51:11.539159Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"d71a1778b31d4ce has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-18T17:51:11.539193Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-04-18T17:51:11.539273Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-04-18T17:51:11.539966Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-04-18T17:51:11.540811Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:controller ClientURLs:[https://199.204.45.109:2379]}","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T17:51:11.541113Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T17:51:11.541378Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T17:51:11.541659Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T17:51:11.541681Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T17:51:11.543063Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.6"} {"level":"info","ts":"2026-04-18T17:51:11.543173Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-04-18T17:51:11.543263Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-04-18T17:51:11.543467Z","caller":"version/monitor.go:116","msg":"cluster version differs from storage version.","cluster-version":"3.6.0","storage-version":"3.5.0"} {"level":"info","ts":"2026-04-18T17:51:11.543782Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-04-18T17:51:11.545211Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-04-18T17:51:11.547200Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-04-18T17:51:11.548310Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-18T17:51:11.552420Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T17:51:11.552788Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"warn","ts":"2026-04-18T17:51:12.514416Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50876","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.531812Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50896","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.539322Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50920","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.553042Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50954","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.571624Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50960","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.578733Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50982","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.587737Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50998","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.596404Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51008","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.608631Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51030","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.619684Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51066","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.623585Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51088","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.631752Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51104","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.643262Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51128","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.658386Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51160","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.667300Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51184","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.675761Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51206","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.684768Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51212","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.694278Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51230","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.704603Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51240","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.757181Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51284","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.769130Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51302","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.776225Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51308","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.786995Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51320","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.795994Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51344","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.806455Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51356","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.818034Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51368","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.826810Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51382","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.836649Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51396","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.844945Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51410","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.855944Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51418","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.868885Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51438","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.881915Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51456","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.889034Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51480","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.896803Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51494","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.905577Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51502","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.913474Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51514","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.921304Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51550","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.933348Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51564","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.938581Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51588","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.945854Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51598","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.954704Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51610","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.963216Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51640","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.971955Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51656","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:12.982402Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51674","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.002073Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51692","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.025795Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51718","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.033954Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51750","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.044038Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51768","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.053324Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51792","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.060972Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51810","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.069395Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51838","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.076296Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51876","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.084411Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.092079Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51898","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.123680Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51920","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.129724Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51932","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.139167Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51936","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:13.189822Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51956","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-18T17:51:17.963022Z","caller":"traceutil/trace.go:172","msg":"trace[1149970745] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:323; }","duration":"349.390599ms","start":"2026-04-18T17:51:17.613598Z","end":"2026-04-18T17:51:17.962988Z","steps":["trace[1149970745] 'read index received' (duration: 349.380898ms)","trace[1149970745] 'applied index is now lower than readState.Index' (duration: 8.301µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:17.963336Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"349.664731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-controller\" limit:1 ","response":"range_response_count:1 size:4342"} {"level":"info","ts":"2026-04-18T17:51:17.963321Z","caller":"traceutil/trace.go:172","msg":"trace[623668190] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"480.335724ms","start":"2026-04-18T17:51:17.482953Z","end":"2026-04-18T17:51:17.963289Z","steps":["trace[623668190] 'process raft request' (duration: 480.099814ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:17.963400Z","caller":"traceutil/trace.go:172","msg":"trace[4162890] range","detail":"{range_begin:/registry/pods/kube-system/etcd-controller; range_end:; response_count:1; response_revision:314; }","duration":"349.798796ms","start":"2026-04-18T17:51:17.613591Z","end":"2026-04-18T17:51:17.963390Z","steps":["trace[4162890] 'agreement among raft nodes before linearized reading' (duration: 349.543075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:17.963435Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:17.613565Z","time spent":"349.861419ms","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":4365,"request content":"key:\"/registry/pods/kube-system/etcd-controller\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:51:17.963902Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:17.482932Z","time spent":"480.483691ms","remote":"127.0.0.1:50976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":769,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:51:17.974385Z","caller":"traceutil/trace.go:172","msg":"trace[658293918] transaction","detail":"{read_only:false; number_of_response:0; response_revision:316; }","duration":"360.58866ms","start":"2026-04-18T17:51:17.613773Z","end":"2026-04-18T17:51:17.974362Z","steps":["trace[658293918] 'process raft request' (duration: 360.560118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:17.974518Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:17.613747Z","time spent":"360.719025ms","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:51:17.974640Z","caller":"traceutil/trace.go:172","msg":"trace[684224590] transaction","detail":"{read_only:false; number_of_response:0; response_revision:316; }","duration":"360.937435ms","start":"2026-04-18T17:51:17.613685Z","end":"2026-04-18T17:51:17.974622Z","steps":["trace[684224590] 'process raft request' (duration: 360.559609ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:17.974689Z","caller":"traceutil/trace.go:172","msg":"trace[2007333822] transaction","detail":"{read_only:false; number_of_response:0; response_revision:316; }","duration":"360.946345ms","start":"2026-04-18T17:51:17.613724Z","end":"2026-04-18T17:51:17.974670Z","steps":["trace[2007333822] 'process raft request' (duration: 360.568099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:17.974713Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:17.613663Z","time spent":"361.018979ms","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:51:17.974754Z","caller":"traceutil/trace.go:172","msg":"trace[503518366] transaction","detail":"{read_only:false; number_of_response:0; response_revision:316; }","duration":"360.941695ms","start":"2026-04-18T17:51:17.613799Z","end":"2026-04-18T17:51:17.974740Z","steps":["trace[503518366] 'process raft request' (duration: 360.517697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:17.974769Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:17.613684Z","time spent":"361.04679ms","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:51:17.974808Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:17.613792Z","time spent":"360.990767ms","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:51:17.974917Z","caller":"traceutil/trace.go:172","msg":"trace[1782161834] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"463.348349ms","start":"2026-04-18T17:51:17.511557Z","end":"2026-04-18T17:51:17.974905Z","steps":["trace[1782161834] 'process raft request' (duration: 462.547643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:17.974986Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:17.511533Z","time spent":"463.406221ms","remote":"127.0.0.1:51256","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-04-18T17:51:21.797453Z","caller":"traceutil/trace.go:172","msg":"trace[502933557] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"107.186322ms","start":"2026-04-18T17:51:21.690246Z","end":"2026-04-18T17:51:21.797433Z","steps":["trace[502933557] 'process raft request' (duration: 107.048536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:23.488914Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"687.055209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" limit:1 ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-04-18T17:51:23.488973Z","caller":"traceutil/trace.go:172","msg":"trace[527875422] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:403; }","duration":"687.124901ms","start":"2026-04-18T17:51:22.801837Z","end":"2026-04-18T17:51:23.488962Z","steps":["trace[527875422] 'range keys from in-memory index tree' (duration: 686.826369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:23.488996Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:22.801812Z","time spent":"687.179184ms","remote":"127.0.0.1:51256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":208,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" limit:1 "} {"level":"info","ts":"2026-04-18T17:51:27.238386Z","caller":"traceutil/trace.go:172","msg":"trace[583128932] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"162.296294ms","start":"2026-04-18T17:51:27.076075Z","end":"2026-04-18T17:51:27.238371Z","steps":["trace[583128932] 'process raft request' (duration: 162.150428ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:30.218550Z","caller":"traceutil/trace.go:172","msg":"trace[179147042] linearizableReadLoop","detail":"{readStateIndex:474; appliedIndex:474; }","duration":"130.499022ms","start":"2026-04-18T17:51:30.088030Z","end":"2026-04-18T17:51:30.218529Z","steps":["trace[179147042] 'read index received' (duration: 130.489262ms)","trace[179147042] 'applied index is now lower than readState.Index' (duration: 8.87µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:30.218740Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"130.691409ms","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-04-18T17:51:30.218761Z","caller":"traceutil/trace.go:172","msg":"trace[492313606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:459; }","duration":"130.731351ms","start":"2026-04-18T17:51:30.088025Z","end":"2026-04-18T17:51:30.218757Z","steps":["trace[492313606] 'agreement among raft nodes before linearized reading' (duration: 130.603106ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:30.219040Z","caller":"traceutil/trace.go:172","msg":"trace[953764245] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"172.035868ms","start":"2026-04-18T17:51:30.046956Z","end":"2026-04-18T17:51:30.218992Z","steps":["trace[953764245] 'process raft request' (duration: 171.621612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:32.730028Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269719,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T17:51:32.890133Z","caller":"traceutil/trace.go:172","msg":"trace[924569877] linearizableReadLoop","detail":"{readStateIndex:479; appliedIndex:479; }","duration":"660.390929ms","start":"2026-04-18T17:51:32.229711Z","end":"2026-04-18T17:51:32.890102Z","steps":["trace[924569877] 'read index received' (duration: 660.380818ms)","trace[924569877] 'applied index is now lower than readState.Index' (duration: 8.531µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:32.890465Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"660.732342ms","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-04-18T17:51:32.890540Z","caller":"traceutil/trace.go:172","msg":"trace[1697665203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:463; }","duration":"660.812055ms","start":"2026-04-18T17:51:32.229708Z","end":"2026-04-18T17:51:32.890520Z","steps":["trace[1697665203] 'agreement among raft nodes before linearized reading' (duration: 660.569046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:32.890585Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:32.229701Z","time spent":"660.870837ms","remote":"127.0.0.1:51350","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-04-18T17:51:32.890612Z","caller":"traceutil/trace.go:172","msg":"trace[116231985] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"666.486847ms","start":"2026-04-18T17:51:32.224103Z","end":"2026-04-18T17:51:32.890590Z","steps":["trace[116231985] 'process raft request' (duration: 666.323411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:32.890997Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:32.224087Z","time spent":"666.606842ms","remote":"127.0.0.1:51350","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-04-18T17:51:32.915550Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"294.059118ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:32.915608Z","caller":"traceutil/trace.go:172","msg":"trace[1675137693] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:464; }","duration":"294.12874ms","start":"2026-04-18T17:51:32.621467Z","end":"2026-04-18T17:51:32.915595Z","steps":["trace[1675137693] 'agreement among raft nodes before linearized reading' (duration: 294.027567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:32.915567Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"427.952926ms","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-04-18T17:51:32.915680Z","caller":"traceutil/trace.go:172","msg":"trace[1111316584] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"378.790028ms","start":"2026-04-18T17:51:32.536868Z","end":"2026-04-18T17:51:32.915658Z","steps":["trace[1111316584] 'process raft request' (duration: 378.645052ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:32.915983Z","caller":"traceutil/trace.go:172","msg":"trace[1749942305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:464; }","duration":"428.122923ms","start":"2026-04-18T17:51:32.487590Z","end":"2026-04-18T17:51:32.915713Z","steps":["trace[1749942305] 'agreement among raft nodes before linearized reading' (duration: 427.856443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:32.916020Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:32.536846Z","time spent":"378.911371ms","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:51:32.916402Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:32.487564Z","time spent":"428.544369ms","remote":"127.0.0.1:51350","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-04-18T17:51:33.185178Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"218.789695ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:51:33.185272Z","caller":"traceutil/trace.go:172","msg":"trace[1647690506] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"265.044945ms","start":"2026-04-18T17:51:32.920213Z","end":"2026-04-18T17:51:33.185258Z","steps":["trace[1647690506] 'process raft request' (duration: 45.98023ms)","trace[1647690506] 'compare' (duration: 218.500964ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:35.740501Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"118.721956ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:35.740682Z","caller":"traceutil/trace.go:172","msg":"trace[2121396149] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:473; }","duration":"118.917783ms","start":"2026-04-18T17:51:35.621744Z","end":"2026-04-18T17:51:35.740662Z","steps":["trace[2121396149] 'range keys from in-memory index tree' (duration: 118.665444ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:39.356281Z","caller":"traceutil/trace.go:172","msg":"trace[2106120196] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:495; }","duration":"409.341872ms","start":"2026-04-18T17:51:38.946903Z","end":"2026-04-18T17:51:39.356245Z","steps":["trace[2106120196] 'read index received' (duration: 409.324251ms)","trace[2106120196] 'applied index is now lower than readState.Index' (duration: 15.771µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:51:39.356467Z","caller":"traceutil/trace.go:172","msg":"trace[807350172] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"447.543077ms","start":"2026-04-18T17:51:38.908899Z","end":"2026-04-18T17:51:39.356443Z","steps":["trace[807350172] 'process raft request' (duration: 447.414092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:39.356573Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"409.649832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-04-18T17:51:39.356605Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:38.908869Z","time spent":"447.665141ms","remote":"127.0.0.1:51350","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-04-18T17:51:39.356642Z","caller":"traceutil/trace.go:172","msg":"trace[423110253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:479; }","duration":"409.726495ms","start":"2026-04-18T17:51:38.946896Z","end":"2026-04-18T17:51:39.356623Z","steps":["trace[423110253] 'agreement among raft nodes before linearized reading' (duration: 409.504197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:39.356679Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:38.946884Z","time spent":"409.787057ms","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-04-18T17:51:39.833311Z","caller":"traceutil/trace.go:172","msg":"trace[374458108] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:496; }","duration":"476.905968ms","start":"2026-04-18T17:51:39.356375Z","end":"2026-04-18T17:51:39.833281Z","steps":["trace[374458108] 'read index received' (duration: 476.844065ms)","trace[374458108] 'applied index is now lower than readState.Index' (duration: 60.032µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:40.597014Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"976.012837ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:40.597089Z","caller":"traceutil/trace.go:172","msg":"trace[845662177] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:479; }","duration":"976.09647ms","start":"2026-04-18T17:51:39.620978Z","end":"2026-04-18T17:51:40.597074Z","steps":["trace[845662177] 'range keys from in-memory index tree' (duration: 975.959996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:40.597173Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.389662939s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:40.597238Z","caller":"traceutil/trace.go:172","msg":"trace[825014133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:479; }","duration":"1.389723921s","start":"2026-04-18T17:51:39.207495Z","end":"2026-04-18T17:51:40.597219Z","steps":["trace[825014133] 'agreement among raft nodes before linearized reading' (duration: 625.893621ms)","trace[825014133] 'range keys from in-memory index tree' (duration: 763.736066ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:40.597270Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:39.207440Z","time spent":"1.389824674s","remote":"127.0.0.1:50880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:51:40.597173Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.360308715s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-18T17:51:40.597358Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"763.814099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:51:40.597363Z","caller":"traceutil/trace.go:172","msg":"trace[993509668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:479; }","duration":"1.360510742s","start":"2026-04-18T17:51:39.236838Z","end":"2026-04-18T17:51:40.597349Z","steps":["trace[993509668] 'agreement among raft nodes before linearized reading' (duration: 596.476576ms)","trace[993509668] 'range keys from in-memory index tree' (duration: 763.713766ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:40.597489Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:39.236803Z","time spent":"1.360677418s","remote":"127.0.0.1:51350","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-04-18T17:51:40.597512Z","caller":"traceutil/trace.go:172","msg":"trace[1301940717] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"1.661033534s","start":"2026-04-18T17:51:38.936466Z","end":"2026-04-18T17:51:40.597499Z","steps":["trace[1301940717] 'process raft request' (duration: 897.020878ms)","trace[1301940717] 'compare' (duration: 763.511988ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:51:40.597517Z","caller":"traceutil/trace.go:172","msg":"trace[1772779545] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"1.236378925s","start":"2026-04-18T17:51:39.361124Z","end":"2026-04-18T17:51:40.597503Z","steps":["trace[1772779545] 'process raft request' (duration: 1.236300432s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:40.597598Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:39.361089Z","time spent":"1.236458547s","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:51:40.597598Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:38.936429Z","time spent":"1.661115817s","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:51:41.104805Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269766,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:41.605847Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269766,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:42.107171Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269766,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:42.189923Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.58917663s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T17:51:42.190270Z","caller":"traceutil/trace.go:172","msg":"trace[1285322471] linearizableReadLoop","detail":"{readStateIndex:498; appliedIndex:498; }","duration":"1.586418995s","start":"2026-04-18T17:51:40.603808Z","end":"2026-04-18T17:51:42.190227Z","steps":["trace[1285322471] 'read index received' (duration: 1.586404934s)","trace[1285322471] 'applied index is now lower than readState.Index' (duration: 11.941µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:42.190465Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.586634222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:42.190503Z","caller":"traceutil/trace.go:172","msg":"trace[1483541956] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:481; }","duration":"1.586689364s","start":"2026-04-18T17:51:40.603804Z","end":"2026-04-18T17:51:42.190494Z","steps":["trace[1483541956] 'agreement among raft nodes before linearized reading' (duration: 1.58658105s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:42.190536Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:40.603795Z","time spent":"1.586733915s","remote":"127.0.0.1:50880","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-04-18T17:51:42.190874Z","caller":"traceutil/trace.go:172","msg":"trace[1073272657] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"1.590210145s","start":"2026-04-18T17:51:40.600638Z","end":"2026-04-18T17:51:42.190848Z","steps":["trace[1073272657] 'process raft request' (duration: 1.589698078s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:42.191237Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:40.600621Z","time spent":"1.590506075s","remote":"127.0.0.1:51350","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-04-18T17:51:42.301160Z","caller":"traceutil/trace.go:172","msg":"trace[1562759112] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:499; }","duration":"110.777931ms","start":"2026-04-18T17:51:42.190353Z","end":"2026-04-18T17:51:42.301131Z","steps":["trace[1562759112] 'read index received' (duration: 110.767431ms)","trace[1562759112] 'applied index is now lower than readState.Index' (duration: 9.03µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:42.307617Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.67688076s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:42.307671Z","caller":"traceutil/trace.go:172","msg":"trace[1589208986] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:482; }","duration":"1.676954342s","start":"2026-04-18T17:51:40.630705Z","end":"2026-04-18T17:51:42.307659Z","steps":["trace[1589208986] 'agreement among raft nodes before linearized reading' (duration: 1.670518444s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:42.307735Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"389.086434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:42.307869Z","caller":"traceutil/trace.go:172","msg":"trace[1410857771] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:482; }","duration":"389.306852ms","start":"2026-04-18T17:51:41.918539Z","end":"2026-04-18T17:51:42.307846Z","steps":["trace[1410857771] 'agreement among raft nodes before linearized reading' (duration: 382.606205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:42.307965Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:41.918520Z","time spent":"389.429076ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":28,"request content":"key:\"/registry/secrets\" limit:1 "} {"level":"info","ts":"2026-04-18T17:51:42.308181Z","caller":"traceutil/trace.go:172","msg":"trace[42758622] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"946.176451ms","start":"2026-04-18T17:51:41.361971Z","end":"2026-04-18T17:51:42.308147Z","steps":["trace[42758622] 'process raft request' (duration: 939.245306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:42.308324Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:41.361941Z","time spent":"946.303945ms","remote":"127.0.0.1:51350","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-04-18T17:51:42.309992Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"118.331227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:42.310050Z","caller":"traceutil/trace.go:172","msg":"trace[1220733354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"118.391479ms","start":"2026-04-18T17:51:42.191646Z","end":"2026-04-18T17:51:42.310037Z","steps":["trace[1220733354] 'agreement among raft nodes before linearized reading' (duration: 116.512965ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:43.427025Z","caller":"traceutil/trace.go:172","msg":"trace[1531275516] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"118.988781ms","start":"2026-04-18T17:51:43.308019Z","end":"2026-04-18T17:51:43.427007Z","steps":["trace[1531275516] 'process raft request' (duration: 53.699181ms)","trace[1531275516] 'compare' (duration: 65.193296ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:43.753234Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"132.799104ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:43.753343Z","caller":"traceutil/trace.go:172","msg":"trace[454057771] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:498; }","duration":"132.936048ms","start":"2026-04-18T17:51:43.620383Z","end":"2026-04-18T17:51:43.753319Z","steps":["trace[454057771] 'range keys from in-memory index tree' (duration: 132.732812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:43.753624Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"197.871806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:51:43.753926Z","caller":"traceutil/trace.go:172","msg":"trace[627541016] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"290.602196ms","start":"2026-04-18T17:51:43.463281Z","end":"2026-04-18T17:51:43.753883Z","steps":["trace[627541016] 'process raft request' (duration: 92.392949ms)","trace[627541016] 'compare' (duration: 197.559166ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:51:43.789214Z","caller":"traceutil/trace.go:172","msg":"trace[1404355659] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"265.652739ms","start":"2026-04-18T17:51:43.523497Z","end":"2026-04-18T17:51:43.789149Z","steps":["trace[1404355659] 'process raft request' (duration: 265.337158ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:43.789243Z","caller":"traceutil/trace.go:172","msg":"trace[535329014] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"239.565994ms","start":"2026-04-18T17:51:43.549653Z","end":"2026-04-18T17:51:43.789219Z","steps":["trace[535329014] 'process raft request' (duration: 239.338707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:46.708406Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269855,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:47.208594Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269855,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:47.709375Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269855,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:48.210493Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269855,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:48.615811Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.994413595s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:48.615906Z","caller":"traceutil/trace.go:172","msg":"trace[1975812610] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:524; }","duration":"2.994540389s","start":"2026-04-18T17:51:45.621346Z","end":"2026-04-18T17:51:48.615886Z","steps":["trace[1975812610] 'range keys from in-memory index tree' (duration: 2.994370644s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:48.711729Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269855,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:49.208706Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.998313104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-18T17:51:49.208845Z","caller":"traceutil/trace.go:172","msg":"trace[903132571] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.998469039s","start":"2026-04-18T17:51:47.210335Z","end":"2026-04-18T17:51:49.208805Z","steps":["trace[903132571] 'agreement among raft nodes before linearized reading' (duration: 1.998304574s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:49.208920Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:47.210297Z","time spent":"1.998613314s","remote":"127.0.0.1:50880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:51:49.212662Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269855,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:49.712844Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142269855,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:50.122876Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"4.582700133s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T17:51:50.123371Z","caller":"traceutil/trace.go:172","msg":"trace[1963486775] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:543; }","duration":"3.915499233s","start":"2026-04-18T17:51:46.207799Z","end":"2026-04-18T17:51:50.123299Z","steps":["trace[1963486775] 'read index received' (duration: 3.915478222s)","trace[1963486775] 'applied index is now lower than readState.Index' (duration: 18.311µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:51:50.123783Z","caller":"traceutil/trace.go:172","msg":"trace[1673087913] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"4.713247807s","start":"2026-04-18T17:51:45.410508Z","end":"2026-04-18T17:51:50.123756Z","steps":["trace[1673087913] 'process raft request' (duration: 4.712871315s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.123942Z","caller":"traceutil/trace.go:172","msg":"trace[1611727244] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"4.711973995s","start":"2026-04-18T17:51:45.411949Z","end":"2026-04-18T17:51:50.123923Z","steps":["trace[1611727244] 'process raft request' (duration: 4.711847541s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.124001Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.410471Z","time spent":"4.713451734s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:51:50.124031Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.411940Z","time spent":"4.712047657s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:51:50.123788Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.915958237s","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-04-18T17:51:50.124129Z","caller":"traceutil/trace.go:172","msg":"trace[1791638284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:524; }","duration":"3.916332558s","start":"2026-04-18T17:51:46.207785Z","end":"2026-04-18T17:51:50.124117Z","steps":["trace[1791638284] 'agreement among raft nodes before linearized reading' (duration: 3.915708089s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.124260Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:46.207763Z","time spent":"3.916487024s","remote":"127.0.0.1:51350","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-04-18T17:51:50.124324Z","caller":"traceutil/trace.go:172","msg":"trace[1280048583] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"4.702766752s","start":"2026-04-18T17:51:45.421528Z","end":"2026-04-18T17:51:50.124295Z","steps":["trace[1280048583] 'process raft request' (duration: 4.702347199s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.124380Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.421493Z","time spent":"4.702860025s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:51:50.124464Z","caller":"traceutil/trace.go:172","msg":"trace[1446139102] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"4.700824788s","start":"2026-04-18T17:51:45.423627Z","end":"2026-04-18T17:51:50.124451Z","steps":["trace[1446139102] 'process raft request' (duration: 4.700637762s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.123889Z","caller":"traceutil/trace.go:172","msg":"trace[183948781] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"4.712238994s","start":"2026-04-18T17:51:45.411618Z","end":"2026-04-18T17:51:50.123857Z","steps":["trace[183948781] 'process raft request' (duration: 4.711998107s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.124524Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.423607Z","time spent":"4.700890459s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:51:50.125083Z","caller":"traceutil/trace.go:172","msg":"trace[1821375536] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"4.701378035s","start":"2026-04-18T17:51:45.423695Z","end":"2026-04-18T17:51:50.125073Z","steps":["trace[1821375536] 'process raft request' (duration: 4.700716745s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.125126Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.423688Z","time spent":"4.701418957s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:51:50.126059Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.411605Z","time spent":"4.712920945s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:51:50.129360Z","caller":"traceutil/trace.go:172","msg":"trace[1473242993] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"4.691112161s","start":"2026-04-18T17:51:45.438216Z","end":"2026-04-18T17:51:50.129329Z","steps":["trace[1473242993] 'process raft request' (duration: 4.687013752s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.129428Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.438200Z","time spent":"4.691198093s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:51:50.269038Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"138.713377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:51:50.269536Z","caller":"traceutil/trace.go:172","msg":"trace[1734028580] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"4.808628308s","start":"2026-04-18T17:51:45.460882Z","end":"2026-04-18T17:51:50.269510Z","steps":["trace[1734028580] 'process raft request' (duration: 4.808446662s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.269601Z","caller":"traceutil/trace.go:172","msg":"trace[233318414] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"4.788092152s","start":"2026-04-18T17:51:45.481462Z","end":"2026-04-18T17:51:50.269554Z","steps":["trace[233318414] 'process raft request' (duration: 4.787953648s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.269705Z","caller":"traceutil/trace.go:172","msg":"trace[1528551356] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:550; }","duration":"146.088158ms","start":"2026-04-18T17:51:50.123608Z","end":"2026-04-18T17:51:50.269696Z","steps":["trace[1528551356] 'read index received' (duration: 137.422666ms)","trace[1528551356] 'applied index is now lower than readState.Index' (duration: 8.664422ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:51:50.269599Z","caller":"traceutil/trace.go:172","msg":"trace[1865363250] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"4.823356622s","start":"2026-04-18T17:51:45.446207Z","end":"2026-04-18T17:51:50.269563Z","steps":["trace[1865363250] 'process raft request' (duration: 4.684032197s)","trace[1865363250] 'compare' (duration: 138.404706ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:50.269833Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.481441Z","time spent":"4.788280638s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:51:50.269672Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.460869Z","time spent":"4.808740551s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:51:50.269882Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.636837666s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-18T17:51:50.270394Z","caller":"traceutil/trace.go:172","msg":"trace[1344582494] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"3.638597893s","start":"2026-04-18T17:51:46.631782Z","end":"2026-04-18T17:51:50.270379Z","steps":["trace[1344582494] 'process raft request' (duration: 3.638260862s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.270405Z","caller":"traceutil/trace.go:172","msg":"trace[563382850] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"2.918611341s","start":"2026-04-18T17:51:47.351776Z","end":"2026-04-18T17:51:50.270388Z","steps":["trace[563382850] 'process raft request' (duration: 2.918476987s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.270506Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:46.631751Z","time spent":"3.638687186s","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:51:50.270404Z","caller":"traceutil/trace.go:172","msg":"trace[666149257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:536; }","duration":"3.637363972s","start":"2026-04-18T17:51:46.633029Z","end":"2026-04-18T17:51:50.270393Z","steps":["trace[666149257] 'agreement among raft nodes before linearized reading' (duration: 3.636693711s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.270615Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:46.633015Z","time spent":"3.637588499s","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:51:50.269968Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.060279998s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:50.270688Z","caller":"traceutil/trace.go:172","msg":"trace[566880217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"1.06099608s","start":"2026-04-18T17:51:49.209682Z","end":"2026-04-18T17:51:50.270679Z","steps":["trace[566880217] 'agreement among raft nodes before linearized reading' (duration: 1.060247597s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.270716Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:49.209658Z","time spent":"1.061049582s","remote":"127.0.0.1:50878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:51:50.270721Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:47.351731Z","time spent":"2.918729594s","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:51:50.269989Z","caller":"traceutil/trace.go:172","msg":"trace[1275933565] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"4.664407201s","start":"2026-04-18T17:51:45.605563Z","end":"2026-04-18T17:51:50.269970Z","steps":["trace[1275933565] 'process raft request' (duration: 4.664104732s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.270012Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.446190Z","time spent":"4.82362051s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:51:50.270945Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.605535Z","time spent":"4.665357411s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:51:50.270043Z","caller":"traceutil/trace.go:172","msg":"trace[762374084] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"4.774775923s","start":"2026-04-18T17:51:45.495259Z","end":"2026-04-18T17:51:50.270035Z","steps":["trace[762374084] 'process raft request' (duration: 4.774245966s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.271057Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.495241Z","time spent":"4.775782865s","remote":"127.0.0.1:50926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:51:50.270109Z","caller":"traceutil/trace.go:172","msg":"trace[1672857003] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"3.94962782s","start":"2026-04-18T17:51:46.320471Z","end":"2026-04-18T17:51:50.270099Z","steps":["trace[1672857003] 'process raft request' (duration: 3.949421994s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.271344Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:46.320444Z","time spent":"3.950776066s","remote":"127.0.0.1:51350","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-04-18T17:51:50.270150Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.654179846s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:50.271732Z","caller":"traceutil/trace.go:172","msg":"trace[495033568] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:538; }","duration":"1.655765406s","start":"2026-04-18T17:51:48.615944Z","end":"2026-04-18T17:51:50.271709Z","steps":["trace[495033568] 'agreement among raft nodes before linearized reading' (duration: 1.654128484s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.269536Z","caller":"traceutil/trace.go:172","msg":"trace[468079332] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"4.815267466s","start":"2026-04-18T17:51:45.454243Z","end":"2026-04-18T17:51:50.269510Z","steps":["trace[468079332] 'process raft request' (duration: 4.814959526s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.278103Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:45.454230Z","time spent":"4.82336174s","remote":"127.0.0.1:50956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:51:50.281988Z","caller":"traceutil/trace.go:172","msg":"trace[603621312] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"146.272043ms","start":"2026-04-18T17:51:50.135682Z","end":"2026-04-18T17:51:50.281954Z","steps":["trace[603621312] 'process raft request' (duration: 145.595332ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.282052Z","caller":"traceutil/trace.go:172","msg":"trace[1100200165] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"150.118445ms","start":"2026-04-18T17:51:50.131880Z","end":"2026-04-18T17:51:50.281999Z","steps":["trace[1100200165] 'process raft request' (duration: 149.161575ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.282465Z","caller":"traceutil/trace.go:172","msg":"trace[931845925] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"148.270416ms","start":"2026-04-18T17:51:50.134151Z","end":"2026-04-18T17:51:50.282422Z","steps":["trace[931845925] 'process raft request' (duration: 147.027677ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.282980Z","caller":"traceutil/trace.go:172","msg":"trace[1151632978] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"148.720881ms","start":"2026-04-18T17:51:50.134238Z","end":"2026-04-18T17:51:50.282959Z","steps":["trace[1151632978] 'process raft request' (duration: 146.993977ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.285624Z","caller":"traceutil/trace.go:172","msg":"trace[1487179875] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"130.380484ms","start":"2026-04-18T17:51:50.154248Z","end":"2026-04-18T17:51:50.284628Z","steps":["trace[1487179875] 'process raft request' (duration: 127.616727ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.286169Z","caller":"traceutil/trace.go:172","msg":"trace[658552320] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"129.329371ms","start":"2026-04-18T17:51:50.155628Z","end":"2026-04-18T17:51:50.284957Z","steps":["trace[658552320] 'process raft request' (duration: 127.865095ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.286464Z","caller":"traceutil/trace.go:172","msg":"trace[473755448] transaction","detail":"{read_only:false; number_of_response:1; response_revision:545; }","duration":"134.856425ms","start":"2026-04-18T17:51:50.150104Z","end":"2026-04-18T17:51:50.284960Z","steps":["trace[473755448] 'process raft request' (duration: 131.609714ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.287737Z","caller":"traceutil/trace.go:172","msg":"trace[185927297] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"134.884476ms","start":"2026-04-18T17:51:50.150070Z","end":"2026-04-18T17:51:50.284955Z","steps":["trace[185927297] 'process raft request' (duration: 131.291054ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.288140Z","caller":"traceutil/trace.go:172","msg":"trace[834429225] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"129.90047ms","start":"2026-04-18T17:51:50.158227Z","end":"2026-04-18T17:51:50.288127Z","steps":["trace[834429225] 'process raft request' (duration: 127.933878ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.288349Z","caller":"traceutil/trace.go:172","msg":"trace[994310249] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"125.351607ms","start":"2026-04-18T17:51:50.162984Z","end":"2026-04-18T17:51:50.288336Z","steps":["trace[994310249] 'process raft request' (duration: 124.927923ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.288491Z","caller":"traceutil/trace.go:172","msg":"trace[222192583] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"133.621947ms","start":"2026-04-18T17:51:50.150999Z","end":"2026-04-18T17:51:50.284621Z","steps":["trace[222192583] 'process raft request' (duration: 130.809609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:50.811373Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"190.151022ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:50.811491Z","caller":"traceutil/trace.go:172","msg":"trace[1771633373] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:580; }","duration":"190.292156ms","start":"2026-04-18T17:51:50.621177Z","end":"2026-04-18T17:51:50.811469Z","steps":["trace[1771633373] 'range keys from in-memory index tree' (duration: 190.061839ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.813319Z","caller":"traceutil/trace.go:172","msg":"trace[193800705] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"147.275135ms","start":"2026-04-18T17:51:50.666027Z","end":"2026-04-18T17:51:50.813302Z","steps":["trace[193800705] 'process raft request' (duration: 147.058128ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.819625Z","caller":"traceutil/trace.go:172","msg":"trace[1210669711] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"136.700004ms","start":"2026-04-18T17:51:50.682899Z","end":"2026-04-18T17:51:50.819599Z","steps":["trace[1210669711] 'process raft request' (duration: 136.215218ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:50.819747Z","caller":"traceutil/trace.go:172","msg":"trace[1850066659] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"130.8648ms","start":"2026-04-18T17:51:50.688867Z","end":"2026-04-18T17:51:50.819732Z","steps":["trace[1850066659] 'process raft request' (duration: 130.476688ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:51.404417Z","caller":"traceutil/trace.go:172","msg":"trace[2079029331] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"125.63022ms","start":"2026-04-18T17:51:51.278767Z","end":"2026-04-18T17:51:51.404397Z","steps":["trace[2079029331] 'process raft request' (duration: 125.496135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:51.540972Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32808","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.626029Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32810","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.698466Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32826","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.724341Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32830","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.771519Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32854","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.800426Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32862","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.814660Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.835956Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32902","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.850089Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32912","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.867415Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32920","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.908928Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32934","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.933806Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32940","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.956100Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32968","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:51.999250Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32976","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:52.022055Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32998","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:52.040386Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33002","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:52.056111Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33022","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:52.080594Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33044","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:52.105669Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33066","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:52.124830Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33082","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:52.142415Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33094","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:51:52.164545Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33108","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-18T17:51:54.847609Z","caller":"traceutil/trace.go:172","msg":"trace[1901904518] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:638; }","duration":"156.427088ms","start":"2026-04-18T17:51:54.691139Z","end":"2026-04-18T17:51:54.847566Z","steps":["trace[1901904518] 'read index received' (duration: 156.413037ms)","trace[1901904518] 'applied index is now lower than readState.Index' (duration: 11.551µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:54.847798Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"156.619973ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:54.847846Z","caller":"traceutil/trace.go:172","msg":"trace[445921983] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:614; }","duration":"156.706306ms","start":"2026-04-18T17:51:54.691126Z","end":"2026-04-18T17:51:54.847832Z","steps":["trace[445921983] 'agreement among raft nodes before linearized reading' (duration: 156.581602ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:51:54.848047Z","caller":"traceutil/trace.go:172","msg":"trace[1905326213] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"299.384388ms","start":"2026-04-18T17:51:54.548640Z","end":"2026-04-18T17:51:54.848024Z","steps":["trace[1905326213] 'process raft request' (duration: 299.020527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:55.571194Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"363.014847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:55.571300Z","caller":"traceutil/trace.go:172","msg":"trace[824756049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"363.12405ms","start":"2026-04-18T17:51:55.208157Z","end":"2026-04-18T17:51:55.571281Z","steps":["trace[824756049] 'range keys from in-memory index tree' (duration: 362.920114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:55.571355Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:55.208135Z","time spent":"363.206073ms","remote":"127.0.0.1:50880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:51:55.571203Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"202.258151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T17:51:55.571597Z","caller":"traceutil/trace.go:172","msg":"trace[158070491] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:615; }","duration":"202.649723ms","start":"2026-04-18T17:51:55.368916Z","end":"2026-04-18T17:51:55.571566Z","steps":["trace[158070491] 'range keys from in-memory index tree' (duration: 201.983823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:58.707488Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270122,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:59.208333Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270122,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:59.708809Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270122,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:51:59.712373Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.581874073s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T17:51:59.712708Z","caller":"traceutil/trace.go:172","msg":"trace[1282833331] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:656; }","duration":"1.506148059s","start":"2026-04-18T17:51:58.206529Z","end":"2026-04-18T17:51:59.712677Z","steps":["trace[1282833331] 'read index received' (duration: 1.506137499s)","trace[1282833331] 'applied index is now lower than readState.Index' (duration: 8.93µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:51:59.712898Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.506346835s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:51:59.712975Z","caller":"traceutil/trace.go:172","msg":"trace[51768131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"1.506440538s","start":"2026-04-18T17:51:58.206514Z","end":"2026-04-18T17:51:59.712954Z","steps":["trace[51768131] 'agreement among raft nodes before linearized reading' (duration: 1.506286464s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:59.713036Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:58.206492Z","time spent":"1.50653284s","remote":"127.0.0.1:50880","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-04-18T17:51:59.713681Z","caller":"traceutil/trace.go:172","msg":"trace[1825915102] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"1.584917632s","start":"2026-04-18T17:51:58.128747Z","end":"2026-04-18T17:51:59.713664Z","steps":["trace[1825915102] 'process raft request' (duration: 1.584207851s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:51:59.713788Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:58.128716Z","time spent":"1.585007765s","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:52:00.212811Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:00.713699Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:01.214508Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:01.714743Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000324833s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-18T17:52:01.714817Z","caller":"traceutil/trace.go:172","msg":"trace[1142986957] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000414935s","start":"2026-04-18T17:51:59.714385Z","end":"2026-04-18T17:52:01.714800Z","steps":["trace[1142986957] 'agreement among raft nodes before linearized reading' (duration: 2.000321023s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:01.714808Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270126,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:01.714975Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:59.714367Z","time spent":"2.000488378s","remote":"127.0.0.1:50878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:52:01.910212Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.197520422s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T17:52:01.910653Z","caller":"traceutil/trace.go:172","msg":"trace[1189090661] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:657; }","duration":"2.197844602s","start":"2026-04-18T17:51:59.712765Z","end":"2026-04-18T17:52:01.910610Z","steps":["trace[1189090661] 'read index received' (duration: 2.197829801s)","trace[1189090661] 'applied index is now lower than readState.Index' (duration: 13.161µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:02.308642Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.90128597s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-04-18T17:52:02.308718Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.688123929s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:02.308757Z","caller":"traceutil/trace.go:172","msg":"trace[1741428007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"3.901398514s","start":"2026-04-18T17:51:58.407320Z","end":"2026-04-18T17:52:02.308719Z","steps":["trace[1741428007] 'agreement among raft nodes before linearized reading' (duration: 3.503415526s)","trace[1741428007] 'range keys from in-memory index tree' (duration: 397.02423ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:02.308809Z","caller":"traceutil/trace.go:172","msg":"trace[1630474969] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:632; }","duration":"3.688218591s","start":"2026-04-18T17:51:58.620565Z","end":"2026-04-18T17:52:02.308784Z","steps":["trace[1630474969] 'agreement among raft nodes before linearized reading' (duration: 3.290069499s)","trace[1630474969] 'range keys from in-memory index tree' (duration: 398.027679ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:02.308822Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:58.407278Z","time spent":"3.901528537s","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:02.308941Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.588352221s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mz59l\" limit:1 ","response":"range_response_count:1 size:18350"} {"level":"info","ts":"2026-04-18T17:52:02.309010Z","caller":"traceutil/trace.go:172","msg":"trace[727759305] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mz59l; range_end:; response_count:1; response_revision:632; }","duration":"3.588429353s","start":"2026-04-18T17:51:58.720562Z","end":"2026-04-18T17:52:02.308992Z","steps":["trace[727759305] 'agreement among raft nodes before linearized reading' (duration: 3.190088346s)","trace[727759305] 'range keys from in-memory index tree' (duration: 397.872304ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:02.309049Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:58.720515Z","time spent":"3.588523966s","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18373,"request content":"key:\"/registry/pods/kube-system/cilium-mz59l\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:02.309460Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.8944313s","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-04-18T17:52:02.309533Z","caller":"traceutil/trace.go:172","msg":"trace[685245721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"3.894659536s","start":"2026-04-18T17:51:58.414823Z","end":"2026-04-18T17:52:02.309482Z","steps":["trace[685245721] 'agreement among raft nodes before linearized reading' (duration: 3.495870646s)","trace[685245721] 'range keys from in-memory index tree' (duration: 398.100291ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:02.309567Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:58.414783Z","time spent":"3.894774039s","remote":"127.0.0.1:51350","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-04-18T17:52:02.319774Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"398.302806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:02.319922Z","caller":"traceutil/trace.go:172","msg":"trace[1948722716] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.78988193s","start":"2026-04-18T17:52:00.530032Z","end":"2026-04-18T17:52:02.319914Z","steps":["trace[1948722716] 'process raft request' (duration: 1.789858799s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:02.319960Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:00.530007Z","time spent":"1.789934112s","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:02.320011Z","caller":"traceutil/trace.go:172","msg":"trace[1127590645] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"3.911892149s","start":"2026-04-18T17:51:58.408101Z","end":"2026-04-18T17:52:02.319993Z","steps":["trace[1127590645] 'process raft request' (duration: 3.911716554s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:02.320097Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:58.408062Z","time spent":"3.911990363s","remote":"127.0.0.1:51350","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-04-18T17:52:02.320225Z","caller":"traceutil/trace.go:172","msg":"trace[1898282141] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"3.976286402s","start":"2026-04-18T17:51:58.343931Z","end":"2026-04-18T17:52:02.320218Z","steps":["trace[1898282141] 'process raft request' (duration: 3.56679896s)","trace[1898282141] 'compare' (duration: 398.183203ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:02.320259Z","caller":"traceutil/trace.go:172","msg":"trace[1559093492] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"409.498403ms","start":"2026-04-18T17:52:01.910744Z","end":"2026-04-18T17:52:02.320242Z","steps":["trace[1559093492] 'read index received' (duration: 330.346606ms)","trace[1559093492] 'applied index is now lower than readState.Index' (duration: 79.150867ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:02.320294Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:58.343893Z","time spent":"3.976365565s","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:52:02.320330Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"585.124066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:02.320348Z","caller":"traceutil/trace.go:172","msg":"trace[33856167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"585.142537ms","start":"2026-04-18T17:52:01.735200Z","end":"2026-04-18T17:52:02.320342Z","steps":["trace[33856167] 'agreement among raft nodes before linearized reading' (duration: 585.108266ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:02.320364Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:01.735175Z","time spent":"585.185778ms","remote":"127.0.0.1:50880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:52:02.320497Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"591.632462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-controller.18a784e810f0c047\" limit:1 ","response":"range_response_count:1 size:784"} {"level":"info","ts":"2026-04-18T17:52:02.320516Z","caller":"traceutil/trace.go:172","msg":"trace[1268188870] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-controller.18a784e810f0c047; range_end:; response_count:1; response_revision:636; }","duration":"591.651673ms","start":"2026-04-18T17:52:01.728859Z","end":"2026-04-18T17:52:02.320510Z","steps":["trace[1268188870] 'agreement among raft nodes before linearized reading' (duration: 591.5728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:02.320528Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:01.728835Z","time spent":"591.689244ms","remote":"127.0.0.1:50976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":807,"request content":"key:\"/registry/events/kube-system/kube-apiserver-controller.18a784e810f0c047\" limit:1 "} {"level":"info","ts":"2026-04-18T17:52:02.320650Z","caller":"traceutil/trace.go:172","msg":"trace[1040193037] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"2.553666878s","start":"2026-04-18T17:51:59.766977Z","end":"2026-04-18T17:52:02.320644Z","steps":["trace[1040193037] 'process raft request' (duration: 2.552893037s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:02.320681Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:51:59.766950Z","time spent":"2.553716299s","remote":"127.0.0.1:51498","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-04-18T17:52:03.100429Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.041548ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:03.100699Z","caller":"traceutil/trace.go:172","msg":"trace[532163760] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"222.428802ms","start":"2026-04-18T17:52:02.878249Z","end":"2026-04-18T17:52:03.100678Z","steps":["trace[532163760] 'process raft request' (duration: 113.074575ms)","trace[532163760] 'compare' (duration: 108.860883ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:04.423950Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"434.296699ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:04.424102Z","caller":"traceutil/trace.go:172","msg":"trace[722785805] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:655; }","duration":"434.452463ms","start":"2026-04-18T17:52:03.989625Z","end":"2026-04-18T17:52:04.424078Z","steps":["trace[722785805] 'range keys from in-memory index tree' (duration: 434.251417ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:04.429744Z","caller":"traceutil/trace.go:172","msg":"trace[1027676972] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:681; }","duration":"222.84419ms","start":"2026-04-18T17:52:04.206869Z","end":"2026-04-18T17:52:04.429713Z","steps":["trace[1027676972] 'read index received' (duration: 222.832239ms)","trace[1027676972] 'applied index is now lower than readState.Index' (duration: 10.161µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:04.430072Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"223.20451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:04.430256Z","caller":"traceutil/trace.go:172","msg":"trace[534175186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:655; }","duration":"223.383445ms","start":"2026-04-18T17:52:04.206850Z","end":"2026-04-18T17:52:04.430233Z","steps":["trace[534175186] 'agreement among raft nodes before linearized reading' (duration: 223.094197ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:04.433879Z","caller":"traceutil/trace.go:172","msg":"trace[1135007291] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"462.705103ms","start":"2026-04-18T17:52:03.971143Z","end":"2026-04-18T17:52:04.433848Z","steps":["trace[1135007291] 'process raft request' (duration: 459.36563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:04.434185Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:03.971111Z","time spent":"462.887608ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:04.435156Z","caller":"traceutil/trace.go:172","msg":"trace[243097968] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"110.298114ms","start":"2026-04-18T17:52:04.324811Z","end":"2026-04-18T17:52:04.435109Z","steps":["trace[243097968] 'process raft request' (duration: 110.228092ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:04.435934Z","caller":"traceutil/trace.go:172","msg":"trace[1611072644] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"111.103216ms","start":"2026-04-18T17:52:04.324812Z","end":"2026-04-18T17:52:04.435915Z","steps":["trace[1611072644] 'process raft request' (duration: 110.117189ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:05.536415Z","caller":"traceutil/trace.go:172","msg":"trace[1553790550] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:692; }","duration":"329.444068ms","start":"2026-04-18T17:52:05.206925Z","end":"2026-04-18T17:52:05.536369Z","steps":["trace[1553790550] 'read index received' (duration: 329.434828ms)","trace[1553790550] 'applied index is now lower than readState.Index' (duration: 7.44µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:05.536654Z","caller":"traceutil/trace.go:172","msg":"trace[850947041] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"641.45842ms","start":"2026-04-18T17:52:04.895180Z","end":"2026-04-18T17:52:05.536638Z","steps":["trace[850947041] 'process raft request' (duration: 641.314076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:05.536669Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"329.691244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:52:05.536772Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:04.895154Z","time spent":"641.549572ms","remote":"127.0.0.1:51350","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-04-18T17:52:05.536795Z","caller":"traceutil/trace.go:172","msg":"trace[379339063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:666; }","duration":"329.863359ms","start":"2026-04-18T17:52:05.206911Z","end":"2026-04-18T17:52:05.536774Z","steps":["trace[379339063] 'agreement among raft nodes before linearized reading' (duration: 329.582111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:05.536903Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:05.206886Z","time spent":"329.983223ms","remote":"127.0.0.1:50878","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-04-18T17:52:05.776230Z","caller":"traceutil/trace.go:172","msg":"trace[845566931] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:693; }","duration":"239.628083ms","start":"2026-04-18T17:52:05.536572Z","end":"2026-04-18T17:52:05.776200Z","steps":["trace[845566931] 'read index received' (duration: 239.618163ms)","trace[845566931] 'applied index is now lower than readState.Index' (duration: 8.49µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:05.776489Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"406.958803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T17:52:05.776579Z","caller":"traceutil/trace.go:172","msg":"trace[207490305] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:667; }","duration":"407.061636ms","start":"2026-04-18T17:52:05.369498Z","end":"2026-04-18T17:52:05.776560Z","steps":["trace[207490305] 'agreement among raft nodes before linearized reading' (duration: 406.820629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:05.776620Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:05.369470Z","time spent":"407.140298ms","remote":"127.0.0.1:50926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.109\" limit:1 "} {"level":"info","ts":"2026-04-18T17:52:05.777156Z","caller":"traceutil/trace.go:172","msg":"trace[158564810] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"862.63059ms","start":"2026-04-18T17:52:04.914509Z","end":"2026-04-18T17:52:05.777139Z","steps":["trace[158564810] 'process raft request' (duration: 862.059934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:05.777346Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:04.914487Z","time spent":"862.725142ms","remote":"127.0.0.1:51016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:05.777543Z","caller":"traceutil/trace.go:172","msg":"trace[499868618] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"524.238545ms","start":"2026-04-18T17:52:05.253287Z","end":"2026-04-18T17:52:05.777526Z","steps":["trace[499868618] 'process raft request' (duration: 523.810724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:05.777655Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:05.253262Z","time spent":"524.352698ms","remote":"127.0.0.1:50976","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-04-18T17:52:05.981101Z","caller":"traceutil/trace.go:172","msg":"trace[1010376348] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"149.058827ms","start":"2026-04-18T17:52:05.832017Z","end":"2026-04-18T17:52:05.981076Z","steps":["trace[1010376348] 'process raft request' (duration: 148.907993ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:06.062647Z","caller":"traceutil/trace.go:172","msg":"trace[995738281] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"171.077159ms","start":"2026-04-18T17:52:05.891543Z","end":"2026-04-18T17:52:06.062620Z","steps":["trace[995738281] 'process raft request' (duration: 132.341601ms)","trace[995738281] 'compare' (duration: 38.605685ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:06.062889Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"134.379229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-operator-75968c57df-pfc4v.18a784eb6f9dc6a3\" limit:1 ","response":"range_response_count:1 size:865"} {"level":"info","ts":"2026-04-18T17:52:06.063000Z","caller":"traceutil/trace.go:172","msg":"trace[1400757650] range","detail":"{range_begin:/registry/events/kube-system/cilium-operator-75968c57df-pfc4v.18a784eb6f9dc6a3; range_end:; response_count:1; response_revision:670; }","duration":"134.511382ms","start":"2026-04-18T17:52:05.928440Z","end":"2026-04-18T17:52:06.062951Z","steps":["trace[1400757650] 'agreement among raft nodes before linearized reading' (duration: 95.353782ms)","trace[1400757650] 'range keys from in-memory index tree' (duration: 38.682607ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:08.841084Z","caller":"traceutil/trace.go:172","msg":"trace[234645304] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"121.615971ms","start":"2026-04-18T17:52:08.719446Z","end":"2026-04-18T17:52:08.841062Z","steps":["trace[234645304] 'process raft request' (duration: 94.396249ms)","trace[234645304] 'compare' (duration: 27.125129ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:09.129061Z","caller":"traceutil/trace.go:172","msg":"trace[9666355] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"110.128627ms","start":"2026-04-18T17:52:09.018902Z","end":"2026-04-18T17:52:09.129031Z","steps":["trace[9666355] 'process raft request' (duration: 109.680076ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:09.138392Z","caller":"traceutil/trace.go:172","msg":"trace[901074388] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"105.153535ms","start":"2026-04-18T17:52:09.033225Z","end":"2026-04-18T17:52:09.138378Z","steps":["trace[901074388] 'process raft request' (duration: 105.123644ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:09.138643Z","caller":"traceutil/trace.go:172","msg":"trace[1031383999] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"105.576356ms","start":"2026-04-18T17:52:09.033059Z","end":"2026-04-18T17:52:09.138636Z","steps":["trace[1031383999] 'process raft request' (duration: 105.223876ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:10.880035Z","caller":"traceutil/trace.go:172","msg":"trace[334539340] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"127.629487ms","start":"2026-04-18T17:52:10.752380Z","end":"2026-04-18T17:52:10.880010Z","steps":["trace[334539340] 'process raft request' (duration: 127.479093ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:12.866309Z","caller":"traceutil/trace.go:172","msg":"trace[1595387752] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:790; }","duration":"115.921909ms","start":"2026-04-18T17:52:12.750351Z","end":"2026-04-18T17:52:12.866273Z","steps":["trace[1595387752] 'read index received' (duration: 115.909569ms)","trace[1595387752] 'applied index is now lower than readState.Index' (duration: 10.51µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:12.979143Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"228.783059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" limit:1 ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-04-18T17:52:12.979199Z","caller":"traceutil/trace.go:172","msg":"trace[69812026] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:762; }","duration":"228.85445ms","start":"2026-04-18T17:52:12.750332Z","end":"2026-04-18T17:52:12.979187Z","steps":["trace[69812026] 'agreement among raft nodes before linearized reading' (duration: 116.073853ms)","trace[69812026] 'range keys from in-memory index tree' (duration: 112.604793ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:12.979394Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"112.90935ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:12.979574Z","caller":"traceutil/trace.go:172","msg":"trace[1009810931] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"255.505484ms","start":"2026-04-18T17:52:12.724023Z","end":"2026-04-18T17:52:12.979529Z","steps":["trace[1009810931] 'process raft request' (duration: 142.376078ms)","trace[1009810931] 'compare' (duration: 112.724936ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:13.024881Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34804","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:14.105969Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34814","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:14.119573Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34822","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:14.224766Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34832","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:14.245193Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34862","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:14.409011Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.046848Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34884","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.436560Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"127.268024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:16.436702Z","caller":"traceutil/trace.go:172","msg":"trace[2081534799] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"211.296136ms","start":"2026-04-18T17:52:16.225382Z","end":"2026-04-18T17:52:16.436679Z","steps":["trace[2081534799] 'process raft request' (duration: 83.829967ms)","trace[2081534799] 'compare' (duration: 127.042518ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:16.488918Z","caller":"traceutil/trace.go:172","msg":"trace[1246836395] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"237.126829ms","start":"2026-04-18T17:52:16.251165Z","end":"2026-04-18T17:52:16.488292Z","steps":["trace[1246836395] 'process raft request' (duration: 236.954064ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:16.613504Z","caller":"traceutil/trace.go:172","msg":"trace[958320292] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"111.67628ms","start":"2026-04-18T17:52:16.501814Z","end":"2026-04-18T17:52:16.613490Z","steps":["trace[958320292] 'process raft request' (duration: 111.640349ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:16.613547Z","caller":"traceutil/trace.go:172","msg":"trace[1935223547] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"114.751518ms","start":"2026-04-18T17:52:16.498771Z","end":"2026-04-18T17:52:16.613522Z","steps":["trace[1935223547] 'process raft request' (duration: 47.87719ms)","trace[1935223547] 'compare' (duration: 66.705324ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:21.494214Z","caller":"traceutil/trace.go:172","msg":"trace[1886261778] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"188.710062ms","start":"2026-04-18T17:52:21.305476Z","end":"2026-04-18T17:52:21.494186Z","steps":["trace[1886261778] 'process raft request' (duration: 188.518647ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.805382Z","caller":"traceutil/trace.go:172","msg":"trace[90164287] linearizableReadLoop","detail":"{readStateIndex:855; appliedIndex:855; }","duration":"163.308796ms","start":"2026-04-18T17:52:22.642041Z","end":"2026-04-18T17:52:22.805350Z","steps":["trace[90164287] 'read index received' (duration: 163.286195ms)","trace[90164287] 'applied index is now lower than readState.Index' (duration: 20.291µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:22.805660Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"163.557732ms","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-04-18T17:52:22.805743Z","caller":"traceutil/trace.go:172","msg":"trace[1206621990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:823; }","duration":"163.691245ms","start":"2026-04-18T17:52:22.642036Z","end":"2026-04-18T17:52:22.805727Z","steps":["trace[1206621990] 'agreement among raft nodes before linearized reading' (duration: 163.429889ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.805749Z","caller":"traceutil/trace.go:172","msg":"trace[1405375603] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"169.957017ms","start":"2026-04-18T17:52:22.635763Z","end":"2026-04-18T17:52:22.805720Z","steps":["trace[1405375603] 'process raft request' (duration: 169.579128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.042934Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"365.257718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-18T17:52:23.043074Z","caller":"traceutil/trace.go:172","msg":"trace[422831394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:824; }","duration":"365.427462ms","start":"2026-04-18T17:52:22.677620Z","end":"2026-04-18T17:52:23.043048Z","steps":["trace[422831394] 'agreement among raft nodes before linearized reading' (duration: 215.278761ms)","trace[422831394] 'range keys from in-memory index tree' (duration: 149.783313ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:23.043188Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.677578Z","time spent":"365.597116ms","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:23.043606Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"150.53176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:23.043764Z","caller":"traceutil/trace.go:172","msg":"trace[530714121] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"404.885415ms","start":"2026-04-18T17:52:22.638848Z","end":"2026-04-18T17:52:23.043733Z","steps":["trace[530714121] 'process raft request' (duration: 254.079908ms)","trace[530714121] 'compare' (duration: 149.926786ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:23.043911Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.638821Z","time spent":"405.008008ms","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:23.044174Z","caller":"traceutil/trace.go:172","msg":"trace[180105083] linearizableReadLoop","detail":"{readStateIndex:858; appliedIndex:856; }","duration":"121.032598ms","start":"2026-04-18T17:52:22.923135Z","end":"2026-04-18T17:52:23.044168Z","steps":["trace[180105083] 'read index received' (duration: 3.957266ms)","trace[180105083] 'applied index is now lower than readState.Index' (duration: 117.074202ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:23.044187Z","caller":"traceutil/trace.go:172","msg":"trace[1339431392] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"310.383662ms","start":"2026-04-18T17:52:22.733768Z","end":"2026-04-18T17:52:23.044152Z","steps":["trace[1339431392] 'process raft request' (duration: 310.068125ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:23.044213Z","caller":"traceutil/trace.go:172","msg":"trace[536998884] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"233.427963ms","start":"2026-04-18T17:52:22.810749Z","end":"2026-04-18T17:52:23.044177Z","steps":["trace[536998884] 'process raft request' (duration: 233.30773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.044232Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"121.104189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:23.044259Z","caller":"traceutil/trace.go:172","msg":"trace[1971262631] range","detail":"{range_begin:/registry/services/specs; range_end:; response_count:0; response_revision:827; }","duration":"121.13479ms","start":"2026-04-18T17:52:22.923120Z","end":"2026-04-18T17:52:23.044254Z","steps":["trace[1971262631] 'agreement among raft nodes before linearized reading' (duration: 121.073938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.044336Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.733741Z","time spent":"310.515106ms","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:52:23.231980Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:37616","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:23.360729Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"152.500928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:52:23.360762Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"117.919928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:23.360806Z","caller":"traceutil/trace.go:172","msg":"trace[763117928] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies; range_end:; response_count:0; response_revision:828; }","duration":"117.971409ms","start":"2026-04-18T17:52:23.242825Z","end":"2026-04-18T17:52:23.360796Z","steps":["trace[763117928] 'range keys from in-memory index tree' (duration: 117.861857ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:23.360809Z","caller":"traceutil/trace.go:172","msg":"trace[771616396] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:828; }","duration":"152.59531ms","start":"2026-04-18T17:52:23.208197Z","end":"2026-04-18T17:52:23.360792Z","steps":["trace[771616396] 'range keys from in-memory index tree' (duration: 152.414666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.360888Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"117.942849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:23.360909Z","caller":"traceutil/trace.go:172","msg":"trace[2080149034] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:828; }","duration":"117.961989ms","start":"2026-04-18T17:52:23.242940Z","end":"2026-04-18T17:52:23.360902Z","steps":["trace[2080149034] 'range keys from in-memory index tree' (duration: 117.918869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.360999Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"202.574119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:23.361036Z","caller":"traceutil/trace.go:172","msg":"trace[126606573] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies; range_end:; response_count:0; response_revision:828; }","duration":"202.61332ms","start":"2026-04-18T17:52:23.158415Z","end":"2026-04-18T17:52:23.361028Z","steps":["trace[126606573] 'range keys from in-memory index tree' (duration: 202.495687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.361132Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"203.382978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:23.361152Z","caller":"traceutil/trace.go:172","msg":"trace[2065401120] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints; range_end:; response_count:0; response_revision:828; }","duration":"203.404199ms","start":"2026-04-18T17:52:23.157743Z","end":"2026-04-18T17:52:23.361147Z","steps":["trace[2065401120] 'range keys from in-memory index tree' (duration: 203.296276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.389454Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:37634","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:23.403750Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:37648","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:23.422327Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:37676","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:23.436289Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:37700","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:23.451168Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:37708","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:23.466738Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:37716","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:24.588503Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"152.526402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:24.588647Z","caller":"traceutil/trace.go:172","msg":"trace[1433028023] range","detail":"{range_begin:/registry/statefulsets; range_end:; response_count:0; response_revision:834; }","duration":"152.688007ms","start":"2026-04-18T17:52:24.435937Z","end":"2026-04-18T17:52:24.588625Z","steps":["trace[1433028023] 'agreement among raft nodes before linearized reading' (duration: 91.147131ms)","trace[1433028023] 'range keys from in-memory index tree' (duration: 61.344692ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:24.589121Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"141.366186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:24.589174Z","caller":"traceutil/trace.go:172","msg":"trace[712449250] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"162.223294ms","start":"2026-04-18T17:52:24.426931Z","end":"2026-04-18T17:52:24.589155Z","steps":["trace[712449250] 'process raft request' (duration: 100.091104ms)","trace[712449250] 'compare' (duration: 61.521055ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:24.589190Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"123.900601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:24.589250Z","caller":"traceutil/trace.go:172","msg":"trace[1962326848] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads; range_end:; response_count:0; response_revision:835; }","duration":"123.961463ms","start":"2026-04-18T17:52:24.465278Z","end":"2026-04-18T17:52:24.589239Z","steps":["trace[1962326848] 'agreement among raft nodes before linearized reading' (duration: 123.87339ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:24.589215Z","caller":"traceutil/trace.go:172","msg":"trace[1245073966] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies; range_end:; response_count:0; response_revision:835; }","duration":"141.415919ms","start":"2026-04-18T17:52:24.447743Z","end":"2026-04-18T17:52:24.589159Z","steps":["trace[1245073966] 'agreement among raft nodes before linearized reading' (duration: 141.340147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:24.589104Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"107.858469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:24.589554Z","caller":"traceutil/trace.go:172","msg":"trace[805563023] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools; range_end:; response_count:0; response_revision:835; }","duration":"108.32574ms","start":"2026-04-18T17:52:24.481218Z","end":"2026-04-18T17:52:24.589544Z","steps":["trace[805563023] 'agreement among raft nodes before linearized reading' (duration: 107.803367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:25.196945Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"151.674928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:25.197034Z","caller":"traceutil/trace.go:172","msg":"trace[1208788101] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"384.806383ms","start":"2026-04-18T17:52:24.812215Z","end":"2026-04-18T17:52:25.197022Z","steps":["trace[1208788101] 'process raft request' (duration: 232.995453ms)","trace[1208788101] 'compare' (duration: 151.568804ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:25.197093Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:24.812185Z","time spent":"384.873634ms","remote":"127.0.0.1:51350","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-04-18T17:52:25.548752Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270573,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:26.049100Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270573,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:26.550105Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270573,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:27.050338Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270573,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:27.203890Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000034858s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-18T17:52:27.203970Z","caller":"traceutil/trace.go:172","msg":"trace[1268602744] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00013283s","start":"2026-04-18T17:52:25.203817Z","end":"2026-04-18T17:52:27.203950Z","steps":["trace[1268602744] 'agreement among raft nodes before linearized reading' (duration: 2.000030248s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:27.204013Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.203803Z","time spent":"2.000203882s","remote":"127.0.0.1:50880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:52:27.550859Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270573,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:28.051396Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367099142270573,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:28.087741Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.467113432s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:28.087803Z","caller":"traceutil/trace.go:172","msg":"trace[2048298536] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:839; }","duration":"2.467182004s","start":"2026-04-18T17:52:25.620605Z","end":"2026-04-18T17:52:28.087787Z","steps":["trace[2048298536] 'range keys from in-memory index tree' (duration: 2.467056771s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:28.528668Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"3.210628722s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T17:52:28.528914Z","caller":"traceutil/trace.go:172","msg":"trace[1311473706] linearizableReadLoop","detail":"{readStateIndex:871; appliedIndex:871; }","duration":"3.481190861s","start":"2026-04-18T17:52:25.047695Z","end":"2026-04-18T17:52:28.528885Z","steps":["trace[1311473706] 'read index received' (duration: 3.481180811s)","trace[1311473706] 'applied index is now lower than readState.Index' (duration: 8.37µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.529151Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.481449497s","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-04-18T17:52:28.529196Z","caller":"traceutil/trace.go:172","msg":"trace[2123178732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:839; }","duration":"3.481503618s","start":"2026-04-18T17:52:25.047681Z","end":"2026-04-18T17:52:28.529184Z","steps":["trace[2123178732] 'agreement among raft nodes before linearized reading' (duration: 3.481295343s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:28.529230Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.047658Z","time spent":"3.481561029s","remote":"127.0.0.1:51350","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-04-18T17:52:28.529243Z","caller":"traceutil/trace.go:172","msg":"trace[317770218] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"3.487429178s","start":"2026-04-18T17:52:25.041793Z","end":"2026-04-18T17:52:28.529222Z","steps":["trace[317770218] 'process raft request' (duration: 3.487265104s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:28.529366Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.041772Z","time spent":"3.48752269s","remote":"127.0.0.1:51294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2879,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:28.790245Z","caller":"traceutil/trace.go:172","msg":"trace[2017113091] linearizableReadLoop","detail":"{readStateIndex:872; appliedIndex:872; }","duration":"261.266832ms","start":"2026-04-18T17:52:28.528956Z","end":"2026-04-18T17:52:28.790223Z","steps":["trace[2017113091] 'read index received' (duration: 261.253922ms)","trace[2017113091] 'applied index is now lower than readState.Index' (duration: 11.95µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.993161Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"576.151185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicybindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:28.993216Z","caller":"traceutil/trace.go:172","msg":"trace[756641315] range","detail":"{range_begin:/registry/validatingadmissionpolicybindings; range_end:; response_count:0; response_revision:840; }","duration":"576.214837ms","start":"2026-04-18T17:52:28.416988Z","end":"2026-04-18T17:52:28.993203Z","steps":["trace[756641315] 'agreement among raft nodes before linearized reading' (duration: 373.335337ms)","trace[756641315] 'range keys from in-memory index tree' (duration: 202.792377ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.993238Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.416976Z","time spent":"576.257087ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/validatingadmissionpolicybindings\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:28.993332Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.362867556s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:52:28.993425Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.788193208s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:28.993442Z","caller":"traceutil/trace.go:172","msg":"trace[1074325004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:840; }","duration":"1.788210208s","start":"2026-04-18T17:52:27.205227Z","end":"2026-04-18T17:52:28.993437Z","steps":["trace[1074325004] 'agreement among raft nodes before linearized reading' (duration: 1.585092293s)","trace[1074325004] 'range keys from in-memory index tree' (duration: 203.092955ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:28.993425Z","caller":"traceutil/trace.go:172","msg":"trace[1388970225] range","detail":"{range_begin:/registry/persistentvolumeclaims; range_end:; response_count:0; response_revision:840; }","duration":"3.362960188s","start":"2026-04-18T17:52:25.630446Z","end":"2026-04-18T17:52:28.993406Z","steps":["trace[1388970225] 'agreement among raft nodes before linearized reading' (duration: 3.159888985s)","trace[1388970225] 'range keys from in-memory index tree' (duration: 202.961711ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.993456Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"639.502963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:28.993702Z","caller":"traceutil/trace.go:172","msg":"trace[648780723] range","detail":"{range_begin:/registry/ingress; range_end:; response_count:0; response_revision:840; }","duration":"639.737819ms","start":"2026-04-18T17:52:28.353896Z","end":"2026-04-18T17:52:28.993634Z","steps":["trace[648780723] 'agreement among raft nodes before linearized reading' (duration: 436.409349ms)","trace[648780723] 'range keys from in-memory index tree' (duration: 203.087284ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.993757Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.353874Z","time spent":"639.869001ms","remote":"127.0.0.1:51394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":28,"request content":"key:\"/registry/ingress\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:28.993759Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"905.901983ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:28.993828Z","caller":"traceutil/trace.go:172","msg":"trace[573226826] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:840; }","duration":"905.978775ms","start":"2026-04-18T17:52:28.087830Z","end":"2026-04-18T17:52:28.993809Z","steps":["trace[573226826] 'agreement among raft nodes before linearized reading' (duration: 702.517762ms)","trace[573226826] 'range keys from in-memory index tree' (duration: 203.367421ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.993595Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.630426Z","time spent":"3.363150452s","remote":"127.0.0.1:51172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:28.994077Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"817.69074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:52:28.994067Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.623995521s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T17:52:28.994107Z","caller":"traceutil/trace.go:172","msg":"trace[251939560] range","detail":"{range_begin:/registry/volumeattachments; range_end:; response_count:0; response_revision:840; }","duration":"817.719781ms","start":"2026-04-18T17:52:28.176376Z","end":"2026-04-18T17:52:28.994096Z","steps":["trace[251939560] 'agreement among raft nodes before linearized reading' (duration: 613.962261ms)","trace[251939560] 'range keys from in-memory index tree' (duration: 203.710529ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.994143Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.176355Z","time spent":"817.779292ms","remote":"127.0.0.1:51596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:28.994176Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.417010396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-18T17:52:28.994144Z","caller":"traceutil/trace.go:172","msg":"trace[1875054825] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:840; }","duration":"3.624073873s","start":"2026-04-18T17:52:25.370046Z","end":"2026-04-18T17:52:28.994120Z","steps":["trace[1875054825] 'agreement among raft nodes before linearized reading' (duration: 3.420294343s)","trace[1875054825] 'range keys from in-memory index tree' (duration: 203.261218ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:28.994271Z","caller":"traceutil/trace.go:172","msg":"trace[2099884335] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:840; }","duration":"3.417045507s","start":"2026-04-18T17:52:25.577155Z","end":"2026-04-18T17:52:28.994200Z","steps":["trace[2099884335] 'agreement among raft nodes before linearized reading' (duration: 3.213189125s)","trace[2099884335] 'range keys from in-memory index tree' (duration: 203.694208ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.994290Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.577132Z","time spent":"3.417152089s","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:28.994349Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.370029Z","time spent":"3.624245117s","remote":"127.0.0.1:50926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.109\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:28.993492Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.875245727s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:28.994477Z","caller":"traceutil/trace.go:172","msg":"trace[478319923] range","detail":"{range_begin:/registry/resourceslices; range_end:; response_count:0; response_revision:840; }","duration":"1.876229511s","start":"2026-04-18T17:52:27.118237Z","end":"2026-04-18T17:52:28.994467Z","steps":["trace[478319923] 'agreement among raft nodes before linearized reading' (duration: 1.672089762s)","trace[478319923] 'range keys from in-memory index tree' (duration: 203.143295ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.994181Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.853720144s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-04-18T17:52:28.994496Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:27.118218Z","time spent":"1.876272222s","remote":"127.0.0.1:51952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/resourceslices\" limit:1 "} {"level":"info","ts":"2026-04-18T17:52:28.994502Z","caller":"traceutil/trace.go:172","msg":"trace[1075992778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:840; }","duration":"3.854038622s","start":"2026-04-18T17:52:25.140455Z","end":"2026-04-18T17:52:28.994493Z","steps":["trace[1075992778] 'agreement among raft nodes before linearized reading' (duration: 3.649847502s)","trace[1075992778] 'range keys from in-memory index tree' (duration: 203.833082ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.994525Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.140433Z","time spent":"3.854085542s","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:28.993520Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.296688614s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:52:28.993454Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:27.205212Z","time spent":"1.788237969s","remote":"127.0.0.1:50878","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-04-18T17:52:28.994688Z","caller":"traceutil/trace.go:172","msg":"trace[1457814552] range","detail":"{range_begin:/registry/certificatesigningrequests; range_end:; response_count:0; response_revision:840; }","duration":"1.29780932s","start":"2026-04-18T17:52:27.696826Z","end":"2026-04-18T17:52:28.994635Z","steps":["trace[1457814552] 'agreement among raft nodes before linearized reading' (duration: 1.093453096s)","trace[1457814552] 'range keys from in-memory index tree' (duration: 203.189347ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.994811Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:27.696802Z","time spent":"1.297969363s","remote":"127.0.0.1:51336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":28,"request content":"key:\"/registry/certificatesigningrequests\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:28.995601Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"205.131531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:28.995904Z","caller":"traceutil/trace.go:172","msg":"trace[1117867811] linearizableReadLoop","detail":"{readStateIndex:875; appliedIndex:872; }","duration":"146.507624ms","start":"2026-04-18T17:52:28.849379Z","end":"2026-04-18T17:52:28.995886Z","steps":["trace[1117867811] 'read index received' (duration: 58.312371ms)","trace[1117867811] 'applied index is now lower than readState.Index' (duration: 88.194163ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:28.995965Z","caller":"traceutil/trace.go:172","msg":"trace[779285028] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"462.326208ms","start":"2026-04-18T17:52:28.533624Z","end":"2026-04-18T17:52:28.995951Z","steps":["trace[779285028] 'process raft request' (duration: 462.228246ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:28.996020Z","caller":"traceutil/trace.go:172","msg":"trace[1123688096] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"1.793946652s","start":"2026-04-18T17:52:27.202062Z","end":"2026-04-18T17:52:28.996009Z","steps":["trace[1123688096] 'process raft request' (duration: 1.793726707s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:28.996073Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:27.202032Z","time spent":"1.794017353s","remote":"127.0.0.1:51350","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-04-18T17:52:28.996083Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.533595Z","time spent":"462.412211ms","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:52:28.996100Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"146.720599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:28.996014Z","caller":"traceutil/trace.go:172","msg":"trace[569392849] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"3.162131658s","start":"2026-04-18T17:52:25.833867Z","end":"2026-04-18T17:52:28.995999Z","steps":["trace[569392849] 'process raft request' (duration: 3.16182058s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:28.996151Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.833846Z","time spent":"3.162290512s","remote":"127.0.0.1:51350","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-04-18T17:52:28.996146Z","caller":"traceutil/trace.go:172","msg":"trace[538632312] range","detail":"{range_begin:/registry/endpointslices; range_end:; response_count:0; response_revision:844; }","duration":"146.76896ms","start":"2026-04-18T17:52:28.849365Z","end":"2026-04-18T17:52:28.996134Z","steps":["trace[538632312] 'agreement among raft nodes before linearized reading' (duration: 146.671447ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:28.996222Z","caller":"traceutil/trace.go:172","msg":"trace[1542528600] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"3.947859639s","start":"2026-04-18T17:52:25.048352Z","end":"2026-04-18T17:52:28.996212Z","steps":["trace[1542528600] 'process raft request' (duration: 3.742035062s)","trace[1542528600] 'compare' (duration: 203.808701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:28.996295Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.048340Z","time spent":"3.94791323s","remote":"127.0.0.1:51350","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-04-18T17:52:29.173255Z","caller":"traceutil/trace.go:172","msg":"trace[475605468] linearizableReadLoop","detail":"{readStateIndex:876; appliedIndex:876; }","duration":"177.273209ms","start":"2026-04-18T17:52:28.995955Z","end":"2026-04-18T17:52:29.173228Z","steps":["trace[475605468] 'read index received' (duration: 177.259989ms)","trace[475605468] 'applied index is now lower than readState.Index' (duration: 11.77µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:29.316306Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"320.7715ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:29.316394Z","caller":"traceutil/trace.go:172","msg":"trace[1758130081] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:844; }","duration":"320.875803ms","start":"2026-04-18T17:52:28.995498Z","end":"2026-04-18T17:52:29.316374Z","steps":["trace[1758130081] 'agreement among raft nodes before linearized reading' (duration: 177.843632ms)","trace[1758130081] 'range keys from in-memory index tree' (duration: 142.896218ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:29.316421Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"143.083732ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-04-18T17:52:29.316502Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.995710Z","time spent":"320.78847ms","remote":"127.0.0.1:50926","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-18T17:52:29.321772Z","caller":"traceutil/trace.go:172","msg":"trace[733731771] linearizableReadLoop","detail":"{readStateIndex:877; appliedIndex:877; }","duration":"148.426585ms","start":"2026-04-18T17:52:29.173324Z","end":"2026-04-18T17:52:29.321750Z","steps":["trace[733731771] 'read index received' (duration: 148.419055ms)","trace[733731771] 'applied index is now lower than readState.Index' (duration: 6.43µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:29.321817Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"320.75576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:52:29.321820Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"319.109701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:52:29.321949Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"322.883429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-controller.18a784e810f0c047\" limit:1 ","response":"range_response_count:1 size:784"} {"level":"info","ts":"2026-04-18T17:52:29.321994Z","caller":"traceutil/trace.go:172","msg":"trace[487460802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:844; }","duration":"319.295356ms","start":"2026-04-18T17:52:29.002689Z","end":"2026-04-18T17:52:29.321984Z","steps":["trace[487460802] 'agreement among raft nodes before linearized reading' (duration: 319.072241ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:29.322010Z","caller":"traceutil/trace.go:172","msg":"trace[1134416732] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-controller.18a784e810f0c047; range_end:; response_count:1; response_revision:844; }","duration":"322.94846ms","start":"2026-04-18T17:52:28.999053Z","end":"2026-04-18T17:52:29.322002Z","steps":["trace[1134416732] 'agreement among raft nodes before linearized reading' (duration: 322.775146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:29.322022Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:29.002677Z","time spent":"319.338556ms","remote":"127.0.0.1:50880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:52:29.322032Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.999046Z","time spent":"322.978451ms","remote":"127.0.0.1:50976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":807,"request content":"key:\"/registry/events/kube-system/kube-apiserver-controller.18a784e810f0c047\" limit:1 "} {"level":"info","ts":"2026-04-18T17:52:29.321848Z","caller":"traceutil/trace.go:172","msg":"trace[1108784353] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:844; }","duration":"320.78924ms","start":"2026-04-18T17:52:29.001049Z","end":"2026-04-18T17:52:29.321838Z","steps":["trace[1108784353] 'agreement among raft nodes before linearized reading' (duration: 320.729599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:29.322185Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:29.001031Z","time spent":"321.108227ms","remote":"127.0.0.1:51220","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":"info","ts":"2026-04-18T17:52:29.322366Z","caller":"traceutil/trace.go:172","msg":"trace[549627469] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"323.37818ms","start":"2026-04-18T17:52:28.998961Z","end":"2026-04-18T17:52:29.322339Z","steps":["trace[549627469] 'process raft request' (duration: 323.306898ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:29.322428Z","caller":"traceutil/trace.go:172","msg":"trace[1266980691] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"323.864032ms","start":"2026-04-18T17:52:28.998504Z","end":"2026-04-18T17:52:29.322368Z","steps":["trace[1266980691] 'process raft request' (duration: 323.496413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:29.322544Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.998944Z","time spent":"323.527313ms","remote":"127.0.0.1:51350","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-04-18T17:52:29.322717Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.998491Z","time spent":"324.036615ms","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":424,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:30.195685Z","caller":"traceutil/trace.go:172","msg":"trace[310598111] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"138.003274ms","start":"2026-04-18T17:52:30.057661Z","end":"2026-04-18T17:52:30.195664Z","steps":["trace[310598111] 'process raft request' (duration: 137.84257ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:34.229471Z","caller":"traceutil/trace.go:172","msg":"trace[455896495] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"147.640446ms","start":"2026-04-18T17:52:34.081806Z","end":"2026-04-18T17:52:34.229446Z","steps":["trace[455896495] 'process raft request' (duration: 147.417991ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:34.378607Z","caller":"traceutil/trace.go:172","msg":"trace[776380499] linearizableReadLoop","detail":"{readStateIndex:939; appliedIndex:939; }","duration":"121.528935ms","start":"2026-04-18T17:52:34.257048Z","end":"2026-04-18T17:52:34.378577Z","steps":["trace[776380499] 'read index received' (duration: 121.513745ms)","trace[776380499] 'applied index is now lower than readState.Index' (duration: 13.27µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:34.461215Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"204.134323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:34.461387Z","caller":"traceutil/trace.go:172","msg":"trace[1494681648] range","detail":"{range_begin:/registry/ingressclasses; range_end:; response_count:0; response_revision:905; }","duration":"204.319268ms","start":"2026-04-18T17:52:34.257043Z","end":"2026-04-18T17:52:34.461363Z","steps":["trace[1494681648] 'agreement among raft nodes before linearized reading' (duration: 121.679808ms)","trace[1494681648] 'range keys from in-memory index tree' (duration: 82.407114ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:34.461694Z","caller":"traceutil/trace.go:172","msg":"trace[506769570] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"226.553142ms","start":"2026-04-18T17:52:34.235120Z","end":"2026-04-18T17:52:34.461673Z","steps":["trace[506769570] 'process raft request' (duration: 143.478253ms)","trace[506769570] 'compare' (duration: 82.776983ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:34.461731Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"197.412894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:34.461860Z","caller":"traceutil/trace.go:172","msg":"trace[194075612] range","detail":"{range_begin:/registry/runtimeclasses; range_end:; response_count:0; response_revision:906; }","duration":"197.550277ms","start":"2026-04-18T17:52:34.264293Z","end":"2026-04-18T17:52:34.461843Z","steps":["trace[194075612] 'agreement among raft nodes before linearized reading' (duration: 197.376253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:35.271725Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"181.863622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:35.271819Z","caller":"traceutil/trace.go:172","msg":"trace[130218653] range","detail":"{range_begin:/registry/storageclasses; range_end:; response_count:0; response_revision:907; }","duration":"181.977044ms","start":"2026-04-18T17:52:35.089822Z","end":"2026-04-18T17:52:35.271799Z","steps":["trace[130218653] 'agreement among raft nodes before linearized reading' (duration: 42.610452ms)","trace[130218653] 'range keys from in-memory index tree' (duration: 139.202928ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:35.272484Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"139.913154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:35.272668Z","caller":"traceutil/trace.go:172","msg":"trace[1328258662] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"254.044398ms","start":"2026-04-18T17:52:35.018565Z","end":"2026-04-18T17:52:35.272610Z","steps":["trace[1328258662] 'process raft request' (duration: 113.94242ms)","trace[1328258662] 'compare' (duration: 139.813952ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:35.272919Z","caller":"traceutil/trace.go:172","msg":"trace[2008230730] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"241.502231ms","start":"2026-04-18T17:52:35.031402Z","end":"2026-04-18T17:52:35.272904Z","steps":["trace[2008230730] 'process raft request' (duration: 241.281526ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:35.716850Z","caller":"traceutil/trace.go:172","msg":"trace[1867138815] linearizableReadLoop","detail":"{readStateIndex:943; appliedIndex:943; }","duration":"346.039332ms","start":"2026-04-18T17:52:35.370782Z","end":"2026-04-18T17:52:35.716822Z","steps":["trace[1867138815] 'read index received' (duration: 346.028152ms)","trace[1867138815] 'applied index is now lower than readState.Index' (duration: 9.94µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:35.767634Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"146.601332ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:35.767707Z","caller":"traceutil/trace.go:172","msg":"trace[1913406857] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:909; }","duration":"146.683784ms","start":"2026-04-18T17:52:35.621008Z","end":"2026-04-18T17:52:35.767691Z","steps":["trace[1913406857] 'range keys from in-memory index tree' (duration: 146.551941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:35.767799Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"396.989769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T17:52:35.767886Z","caller":"traceutil/trace.go:172","msg":"trace[1779361121] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:909; }","duration":"397.094321ms","start":"2026-04-18T17:52:35.370771Z","end":"2026-04-18T17:52:35.767865Z","steps":["trace[1779361121] 'agreement among raft nodes before linearized reading' (duration: 346.148914ms)","trace[1779361121] 'range keys from in-memory index tree' (duration: 50.722471ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:35.767932Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:35.370733Z","time spent":"397.189253ms","remote":"127.0.0.1:50926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.109\" limit:1 "} {"level":"info","ts":"2026-04-18T17:52:35.767966Z","caller":"traceutil/trace.go:172","msg":"trace[1258011304] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"422.417521ms","start":"2026-04-18T17:52:35.345532Z","end":"2026-04-18T17:52:35.767950Z","steps":["trace[1258011304] 'process raft request' (duration: 371.460024ms)","trace[1258011304] 'compare' (duration: 50.264021ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:35.768063Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:35.345513Z","time spent":"422.489533ms","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":478,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:35.789283Z","caller":"traceutil/trace.go:172","msg":"trace[1174823652] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"279.149113ms","start":"2026-04-18T17:52:35.510115Z","end":"2026-04-18T17:52:35.789264Z","steps":["trace[1174823652] 'process raft request' (duration: 279.090432ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:35.789316Z","caller":"traceutil/trace.go:172","msg":"trace[199899415] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"443.448397ms","start":"2026-04-18T17:52:35.345840Z","end":"2026-04-18T17:52:35.789288Z","steps":["trace[199899415] 'process raft request' (duration: 443.201271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:35.789464Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:35.345826Z","time spent":"443.562209ms","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:37.480990Z","caller":"traceutil/trace.go:172","msg":"trace[17861112] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"184.861806ms","start":"2026-04-18T17:52:37.296115Z","end":"2026-04-18T17:52:37.480977Z","steps":["trace[17861112] 'process raft request' (duration: 182.120266ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:43.699799Z","caller":"traceutil/trace.go:172","msg":"trace[2065779772] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"132.252332ms","start":"2026-04-18T17:52:43.567534Z","end":"2026-04-18T17:52:43.699787Z","steps":["trace[2065779772] 'process raft request' (duration: 132.13165ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:43.700972Z","caller":"traceutil/trace.go:172","msg":"trace[2037874497] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"103.067738ms","start":"2026-04-18T17:52:43.597896Z","end":"2026-04-18T17:52:43.700964Z","steps":["trace[2037874497] 'process raft request' (duration: 103.025777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:45.460455Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"243.135347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:45.460523Z","caller":"traceutil/trace.go:172","msg":"trace[1293327192] range","detail":"{range_begin:/registry/cronjobs; range_end:; response_count:0; response_revision:945; }","duration":"243.222819ms","start":"2026-04-18T17:52:45.217286Z","end":"2026-04-18T17:52:45.460509Z","steps":["trace[1293327192] 'range keys from in-memory index tree' (duration: 243.051666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:45.460573Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"180.567876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:45.460643Z","caller":"traceutil/trace.go:172","msg":"trace[1364525811] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations; range_end:; response_count:0; response_revision:945; }","duration":"180.646548ms","start":"2026-04-18T17:52:45.279980Z","end":"2026-04-18T17:52:45.460626Z","steps":["trace[1364525811] 'range keys from in-memory index tree' (duration: 180.480684ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:45.630231Z","caller":"traceutil/trace.go:172","msg":"trace[459236486] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"135.795165ms","start":"2026-04-18T17:52:45.494416Z","end":"2026-04-18T17:52:45.630211Z","steps":["trace[459236486] 'process raft request' (duration: 82.476566ms)","trace[459236486] 'compare' (duration: 53.087494ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:52.039052Z","caller":"traceutil/trace.go:172","msg":"trace[1022599859] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"140.829057ms","start":"2026-04-18T17:52:51.898201Z","end":"2026-04-18T17:52:52.039030Z","steps":["trace[1022599859] 'process raft request' (duration: 140.659924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:03.771548Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"150.455524ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:03.771610Z","caller":"traceutil/trace.go:172","msg":"trace[2085819744] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1010; }","duration":"150.527356ms","start":"2026-04-18T17:53:03.621070Z","end":"2026-04-18T17:53:03.771597Z","steps":["trace[2085819744] 'range keys from in-memory index tree' (duration: 150.403743ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:15.504317Z","caller":"traceutil/trace.go:172","msg":"trace[2118161454] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"111.011688ms","start":"2026-04-18T17:53:15.393283Z","end":"2026-04-18T17:53:15.504294Z","steps":["trace[2118161454] 'process raft request' (duration: 109.242586ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:17.713269Z","caller":"traceutil/trace.go:172","msg":"trace[1868604972] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"244.208365ms","start":"2026-04-18T17:53:17.469043Z","end":"2026-04-18T17:53:17.713251Z","steps":["trace[1868604972] 'process raft request' (duration: 244.050112ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:18.579544Z","caller":"traceutil/trace.go:172","msg":"trace[436318542] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"220.991017ms","start":"2026-04-18T17:53:18.358523Z","end":"2026-04-18T17:53:18.579514Z","steps":["trace[436318542] 'process raft request' (duration: 155.257355ms)","trace[436318542] 'compare' (duration: 65.321355ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:53:40.076581Z","caller":"traceutil/trace.go:172","msg":"trace[1630671072] linearizableReadLoop","detail":"{readStateIndex:1174; appliedIndex:1174; }","duration":"288.024509ms","start":"2026-04-18T17:53:39.788528Z","end":"2026-04-18T17:53:40.076552Z","steps":["trace[1630671072] 'read index received' (duration: 288.014229ms)","trace[1630671072] 'applied index is now lower than readState.Index' (duration: 8.56µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:40.076739Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"288.194613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:40.076780Z","caller":"traceutil/trace.go:172","msg":"trace[1934163420] range","detail":"{range_begin:/registry/volumeattachments; range_end:; response_count:0; response_revision:1127; }","duration":"288.257014ms","start":"2026-04-18T17:53:39.788512Z","end":"2026-04-18T17:53:40.076769Z","steps":["trace[1934163420] 'agreement among raft nodes before linearized reading' (duration: 288.147312ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:40.077022Z","caller":"traceutil/trace.go:172","msg":"trace[543405156] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"294.514845ms","start":"2026-04-18T17:53:39.782487Z","end":"2026-04-18T17:53:40.077002Z","steps":["trace[543405156] 'process raft request' (duration: 294.237181ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:40.083944Z","caller":"traceutil/trace.go:172","msg":"trace[1828171815] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"267.92579ms","start":"2026-04-18T17:53:39.815995Z","end":"2026-04-18T17:53:40.083921Z","steps":["trace[1828171815] 'process raft request' (duration: 267.760387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:40.339442Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"132.206392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:40.339521Z","caller":"traceutil/trace.go:172","msg":"trace[1488571919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1129; }","duration":"132.295143ms","start":"2026-04-18T17:53:40.207209Z","end":"2026-04-18T17:53:40.339504Z","steps":["trace[1488571919] 'range keys from in-memory index tree' (duration: 132.14877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:40.339673Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"150.355747ms","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-04-18T17:53:40.339730Z","caller":"traceutil/trace.go:172","msg":"trace[1184242778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1129; }","duration":"150.414398ms","start":"2026-04-18T17:53:40.189301Z","end":"2026-04-18T17:53:40.339716Z","steps":["trace[1184242778] 'range keys from in-memory index tree' (duration: 150.162305ms)"],"step_count":1}