{"level":"warn","ts":"2026-05-21T22:43:20.660078Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-05-21T22:43:20.660320Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-05-21T22:43:20.660775Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=controller=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138:2380","--name=controller","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-05-21T22:43:20.660996Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-05-21T22:43:20.661046Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T22:43:20.661064Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-05-21T22:43:20.661095Z","caller":"embed/etcd.go:544","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-21T22:43:20.661564Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-05-21T22:43:20.661700Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.204.45.138:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"feature-gates":"InitialCorruptCheck=true","initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","discovery-token":"","discovery-endpoints":"","discovery-dial-timeout":"2s","discovery-request-timeout":"5s","discovery-keepalive-time":"2s","discovery-keepalive-timeout":"6s","discovery-insecure-transport":true,"discovery-insecure-skip-tls-verify":false,"discovery-cert":"","discovery-key":"","discovery-cacert":"","discovery-user":"","downgrade-check-interval":"5s","max-learners":1,"v2-deprecation":"write-only"} {"level":"info","ts":"2026-05-21T22:43:20.662518Z","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: 0xc0003a61b0}"} {"level":"info","ts":"2026-05-21T22:43:20.665973Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-05-21T22:43:20.666028Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.607804ms"} {"level":"info","ts":"2026-05-21T22:43:20.666061Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-05-21T22:43:20.666076Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-05-21T22:43:20.666115Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-05-21T22:43:20.670568Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-05-21T22:43:20.670644Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-05-21T22:43:20.670682Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-05-21T22:43:20.670751Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-05-21T22:43:20.670800Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-05-21T22:43:20.670810Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-21T22:43:20.670824Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-05-21T22:43:20.670862Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-05-21T22:43:20.678084Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-21T22:43:20.680585Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-21T22:43:20.684134Z","caller":"storage/quota.go:93","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-21T22:43:20.686317Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-21T22:43:20.686432Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-21T22:43:20.687359Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T22:43:20.687811Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T22:43:20.687837Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T22:43:20.688011Z","caller":"embed/etcd.go:766","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-21T22:43:20.688211Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-05-21T22:43:20.688277Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-05-21T22:43:20.688338Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-21T22:43:20.688393Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-21T22:43:20.689260Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-05-21T22:43:20.689725Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-05-21T22:43:20.771869Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-05-21T22:43:20.772026Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-21T22:43:20.772184Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-05-21T22:43:20.772279Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"f3d52791b64f7591 has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-21T22:43:20.772423Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-05-21T22:43:20.773149Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-05-21T22:43:20.773278Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"f3d52791b64f7591 has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-21T22:43:20.773423Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-05-21T22:43:20.773556Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-05-21T22:43:20.774639Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:controller ClientURLs:[https://199.204.45.138:2379]}","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-05-21T22:43:20.774766Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-05-21T22:43:20.774692Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T22:43:20.774733Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T22:43:20.774928Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-21T22:43:20.776610Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-21T22:43:20.775619Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.6"} {"level":"info","ts":"2026-05-21T22:43:20.776907Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-05-21T22:43:20.777046Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"warn","ts":"2026-05-21T22:43:20.777866Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-05-21T22:43:20.776402Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-05-21T22:43:20.778274Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-05-21T22:43:20.778398Z","caller":"version/monitor.go:116","msg":"cluster version differs from storage version.","cluster-version":"3.6.0","storage-version":"3.5.0"} {"level":"info","ts":"2026-05-21T22:43:20.779456Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-05-21T22:43:20.781882Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-05-21T22:43:20.783254Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-21T22:43:21.201173Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33246","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.208098Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33254","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.240006Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33292","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.248854Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33298","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.260813Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33332","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.280066Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33364","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.288427Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33384","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.308915Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33406","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.319003Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33422","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.332420Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33452","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.340472Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33480","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.349610Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33484","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.358220Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33504","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.382172Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33540","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.391653Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33556","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.398130Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33576","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.410091Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33594","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.422613Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33608","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.434850Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33614","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.443583Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33642","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.485458Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33680","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.497967Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33684","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.511998Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33692","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.534442Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33726","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.545459Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33740","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.554219Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33760","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.562462Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33772","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.570737Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33798","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.580103Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33810","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.590855Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33840","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.600586Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33878","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.611451Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.628986Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33908","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.636947Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33938","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.648657Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33944","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.662020Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33956","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.678022Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33966","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.686986Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34006","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.696160Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34038","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.704819Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34044","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.725449Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34054","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.735794Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34074","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.746822Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34102","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.771975Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34112","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.785356Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34128","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.794726Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34144","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.803395Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34168","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.811912Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34198","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.819651Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34224","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.829115Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34230","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.840334Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34242","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.850040Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34262","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.856412Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34278","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.867514Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34300","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.880107Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34322","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.915861Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34338","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.925581Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34364","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.936583Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34372","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:43:21.993287Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34396","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-21T22:43:22.695444Z","caller":"traceutil/trace.go:172","msg":"trace[910930978] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:4; }","duration":"270.517933ms","start":"2026-05-21T22:43:22.424895Z","end":"2026-05-21T22:43:22.695413Z","steps":["trace[910930978] 'read index received' (duration: 270.508232ms)","trace[910930978] 'applied index is now lower than readState.Index' (duration: 8.261µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:43:22.695773Z","caller":"traceutil/trace.go:172","msg":"trace[1044627287] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"271.97669ms","start":"2026-05-21T22:43:22.423777Z","end":"2026-05-21T22:43:22.695753Z","steps":["trace[1044627287] 'process raft request' (duration: 271.813606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:22.696500Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"271.536069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/controller\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-21T22:43:22.696543Z","caller":"traceutil/trace.go:172","msg":"trace[1206631652] range","detail":"{range_begin:/registry/csinodes/controller; range_end:; response_count:0; response_revision:2; }","duration":"271.641502ms","start":"2026-05-21T22:43:22.424892Z","end":"2026-05-21T22:43:22.696534Z","steps":["trace[1206631652] 'agreement among raft nodes before linearized reading' (duration: 271.486858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:22.700105Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"132.643034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-21T22:43:22.700137Z","caller":"traceutil/trace.go:172","msg":"trace[1126647076] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:2; }","duration":"132.676665ms","start":"2026-05-21T22:43:22.567452Z","end":"2026-05-21T22:43:22.700129Z","steps":["trace[1126647076] 'agreement among raft nodes before linearized reading' (duration: 132.592403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:22.700152Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"140.392853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-21T22:43:22.700338Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"197.515744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-21T22:43:22.700401Z","caller":"traceutil/trace.go:172","msg":"trace[722936999] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:2; }","duration":"197.577036ms","start":"2026-05-21T22:43:22.502813Z","end":"2026-05-21T22:43:22.700390Z","steps":["trace[722936999] 'agreement among raft nodes before linearized reading' (duration: 197.500964ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.700425Z","caller":"traceutil/trace.go:172","msg":"trace[457078635] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:2; }","duration":"140.581088ms","start":"2026-05-21T22:43:22.559731Z","end":"2026-05-21T22:43:22.700313Z","steps":["trace[457078635] 'agreement among raft nodes before linearized reading' (duration: 140.346342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:22.700394Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"275.358128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/controller\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-21T22:43:22.700628Z","caller":"traceutil/trace.go:172","msg":"trace[761962863] range","detail":"{range_begin:/registry/leases/kube-node-lease/controller; range_end:; response_count:0; response_revision:2; }","duration":"275.563903ms","start":"2026-05-21T22:43:22.425025Z","end":"2026-05-21T22:43:22.700589Z","steps":["trace[761962863] 'agreement among raft nodes before linearized reading' (duration: 275.321597ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.700775Z","caller":"traceutil/trace.go:172","msg":"trace[2032962180] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"195.682937ms","start":"2026-05-21T22:43:22.505083Z","end":"2026-05-21T22:43:22.700766Z","steps":["trace[2032962180] 'process raft request' (duration: 195.42007ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.700843Z","caller":"traceutil/trace.go:172","msg":"trace[290494240] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"180.028674ms","start":"2026-05-21T22:43:22.520801Z","end":"2026-05-21T22:43:22.700830Z","steps":["trace[290494240] 'process raft request' (duration: 179.814559ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.700955Z","caller":"traceutil/trace.go:172","msg":"trace[315245115] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"197.021961ms","start":"2026-05-21T22:43:22.503924Z","end":"2026-05-21T22:43:22.700946Z","steps":["trace[315245115] 'process raft request' (duration: 196.528498ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.701101Z","caller":"traceutil/trace.go:172","msg":"trace[769005324] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"182.948119ms","start":"2026-05-21T22:43:22.518144Z","end":"2026-05-21T22:43:22.701092Z","steps":["trace[769005324] 'process raft request' (duration: 182.432586ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.701122Z","caller":"traceutil/trace.go:172","msg":"trace[1074021311] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"198.184182ms","start":"2026-05-21T22:43:22.502931Z","end":"2026-05-21T22:43:22.701115Z","steps":["trace[1074021311] 'process raft request' (duration: 197.452333ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.701298Z","caller":"traceutil/trace.go:172","msg":"trace[369123618] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"195.622095ms","start":"2026-05-21T22:43:22.505664Z","end":"2026-05-21T22:43:22.701286Z","steps":["trace[369123618] 'process raft request' (duration: 194.856795ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.701317Z","caller":"traceutil/trace.go:172","msg":"trace[2037181214] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"195.600875ms","start":"2026-05-21T22:43:22.505709Z","end":"2026-05-21T22:43:22.701310Z","steps":["trace[2037181214] 'process raft request' (duration: 194.828925ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.701349Z","caller":"traceutil/trace.go:172","msg":"trace[1744752634] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"195.597594ms","start":"2026-05-21T22:43:22.505743Z","end":"2026-05-21T22:43:22.701341Z","steps":["trace[1744752634] 'process raft request' (duration: 194.817964ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:22.701387Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"198.879399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-21T22:43:22.701391Z","caller":"traceutil/trace.go:172","msg":"trace[1869397154] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"196.523828ms","start":"2026-05-21T22:43:22.504845Z","end":"2026-05-21T22:43:22.701369Z","steps":["trace[1869397154] 'process raft request' (duration: 195.643905ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.701418Z","caller":"traceutil/trace.go:172","msg":"trace[956687063] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:0; response_revision:2; }","duration":"200.136811ms","start":"2026-05-21T22:43:22.501273Z","end":"2026-05-21T22:43:22.701410Z","steps":["trace[956687063] 'agreement among raft nodes before linearized reading' (duration: 198.840428ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:22.701555Z","caller":"traceutil/trace.go:172","msg":"trace[207804136] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"197.068313ms","start":"2026-05-21T22:43:22.504477Z","end":"2026-05-21T22:43:22.701546Z","steps":["trace[207804136] 'process raft request' (duration: 195.995925ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:27.466797Z","caller":"traceutil/trace.go:172","msg":"trace[2020615844] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"100.118697ms","start":"2026-05-21T22:43:27.366658Z","end":"2026-05-21T22:43:27.466776Z","steps":["trace[2020615844] 'process raft request' (duration: 99.772258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:27.743751Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"126.737249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-21T22:43:27.743862Z","caller":"traceutil/trace.go:172","msg":"trace[675150852] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:291; }","duration":"126.862712ms","start":"2026-05-21T22:43:27.616980Z","end":"2026-05-21T22:43:27.743843Z","steps":["trace[675150852] 'range keys from in-memory index tree' (duration: 126.524813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:29.502910Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"136.301805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-21T22:43:29.502994Z","caller":"traceutil/trace.go:172","msg":"trace[1475080512] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:305; }","duration":"136.408729ms","start":"2026-05-21T22:43:29.366570Z","end":"2026-05-21T22:43:29.502979Z","steps":["trace[1475080512] 'range keys from in-memory index tree' (duration: 136.103911ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:33.200328Z","caller":"traceutil/trace.go:172","msg":"trace[1391763242] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:377; }","duration":"329.370557ms","start":"2026-05-21T22:43:32.870915Z","end":"2026-05-21T22:43:33.200286Z","steps":["trace[1391763242] 'read index received' (duration: 329.345106ms)","trace[1391763242] 'applied index is now lower than readState.Index' (duration: 9.84µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:43:33.200530Z","caller":"traceutil/trace.go:172","msg":"trace[559092513] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"416.324963ms","start":"2026-05-21T22:43:32.784181Z","end":"2026-05-21T22:43:33.200506Z","steps":["trace[559092513] 'process raft request' (duration: 416.173859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:33.200793Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"329.860748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-21T22:43:33.200862Z","caller":"traceutil/trace.go:172","msg":"trace[181666536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:365; }","duration":"329.952331ms","start":"2026-05-21T22:43:32.870898Z","end":"2026-05-21T22:43:33.200850Z","steps":["trace[181666536] 'agreement among raft nodes before linearized reading' (duration: 329.585161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:33.200958Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:32.870878Z","time spent":"330.068104ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:43:33.202047Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:32.784121Z","time spent":"416.513898ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:43:33.214855Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"305.75633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-21T22:43:33.214896Z","caller":"traceutil/trace.go:172","msg":"trace[967727775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:365; }","duration":"305.801311ms","start":"2026-05-21T22:43:32.909086Z","end":"2026-05-21T22:43:33.214887Z","steps":["trace[967727775] 'agreement among raft nodes before linearized reading' (duration: 305.673068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:33.214931Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:32.909064Z","time spent":"305.848011ms","remote":"127.0.0.1:33730","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-05-21T22:43:35.750695Z","caller":"traceutil/trace.go:172","msg":"trace[1665453210] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"102.106941ms","start":"2026-05-21T22:43:35.648565Z","end":"2026-05-21T22:43:35.750672Z","steps":["trace[1665453210] 'process raft request' (duration: 101.947027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:43.829884Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475499,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-21T22:43:44.039965Z","caller":"traceutil/trace.go:172","msg":"trace[635554954] linearizableReadLoop","detail":"{readStateIndex:447; appliedIndex:447; }","duration":"710.769251ms","start":"2026-05-21T22:43:43.329157Z","end":"2026-05-21T22:43:44.039927Z","steps":["trace[635554954] 'read index received' (duration: 710.759261ms)","trace[635554954] 'applied index is now lower than readState.Index' (duration: 8.48µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:43:44.040189Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"711.011777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-21T22:43:44.040187Z","caller":"traceutil/trace.go:172","msg":"trace[295521054] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"753.621222ms","start":"2026-05-21T22:43:43.286548Z","end":"2026-05-21T22:43:44.040169Z","steps":["trace[295521054] 'process raft request' (duration: 753.473348ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:44.040235Z","caller":"traceutil/trace.go:172","msg":"trace[1721295361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:430; }","duration":"711.073088ms","start":"2026-05-21T22:43:43.329152Z","end":"2026-05-21T22:43:44.040226Z","steps":["trace[1721295361] 'agreement among raft nodes before linearized reading' (duration: 710.903644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:44.040264Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:43.329135Z","time spent":"711.122869ms","remote":"127.0.0.1:33730","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-05-21T22:43:44.040305Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:43.286521Z","time spent":"753.727675ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T22:43:44.144064Z","caller":"traceutil/trace.go:172","msg":"trace[436615458] linearizableReadLoop","detail":"{readStateIndex:448; appliedIndex:448; }","duration":"103.956537ms","start":"2026-05-21T22:43:44.040059Z","end":"2026-05-21T22:43:44.144015Z","steps":["trace[436615458] 'read index received' (duration: 103.936457ms)","trace[436615458] 'applied index is now lower than readState.Index' (duration: 17.8µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:43:44.204672Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"875.437056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-21T22:43:44.204771Z","caller":"traceutil/trace.go:172","msg":"trace[786894187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:431; }","duration":"875.546999ms","start":"2026-05-21T22:43:43.329207Z","end":"2026-05-21T22:43:44.204754Z","steps":["trace[786894187] 'agreement among raft nodes before linearized reading' (duration: 814.992094ms)","trace[786894187] 'range keys from in-memory index tree' (duration: 60.34747ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:43:44.204784Z","caller":"traceutil/trace.go:172","msg":"trace[377796814] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"640.856458ms","start":"2026-05-21T22:43:43.563909Z","end":"2026-05-21T22:43:44.204766Z","steps":["trace[377796814] 'process raft request' (duration: 580.261642ms)","trace[377796814] 'compare' (duration: 60.428442ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:43:44.204807Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:43.329201Z","time spent":"875.598451ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:43:44.204661Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"568.477956ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:43:44.204929Z","caller":"traceutil/trace.go:172","msg":"trace[1163365681] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"160.094946ms","start":"2026-05-21T22:43:44.044793Z","end":"2026-05-21T22:43:44.204888Z","steps":["trace[1163365681] 'process raft request' (duration: 159.904281ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:44.204937Z","caller":"traceutil/trace.go:172","msg":"trace[1074798443] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:431; }","duration":"568.771653ms","start":"2026-05-21T22:43:43.636137Z","end":"2026-05-21T22:43:44.204908Z","steps":["trace[1074798443] 'agreement among raft nodes before linearized reading' (duration: 508.048574ms)","trace[1074798443] 'range keys from in-memory index tree' (duration: 60.394031ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:43:44.204984Z","caller":"traceutil/trace.go:172","msg":"trace[902532851] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"107.905582ms","start":"2026-05-21T22:43:44.097072Z","end":"2026-05-21T22:43:44.204977Z","steps":["trace[902532851] 'process raft request' (duration: 107.787239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:44.204671Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"537.886629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:43:44.205114Z","caller":"traceutil/trace.go:172","msg":"trace[1475226855] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:431; }","duration":"538.34148ms","start":"2026-05-21T22:43:43.666762Z","end":"2026-05-21T22:43:44.205104Z","steps":["trace[1475226855] 'agreement among raft nodes before linearized reading' (duration: 477.408016ms)","trace[1475226855] 'range keys from in-memory index tree' (duration: 60.448142ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:43:44.205145Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:43.666744Z","time spent":"538.393142ms","remote":"127.0.0.1:33262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T22:43:44.204865Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:43.563881Z","time spent":"640.93152ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T22:43:54.324081Z","caller":"traceutil/trace.go:172","msg":"trace[1776214079] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"196.863518ms","start":"2026-05-21T22:43:54.127196Z","end":"2026-05-21T22:43:54.324059Z","steps":["trace[1776214079] 'process raft request' (duration: 196.705124ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:55.442972Z","caller":"traceutil/trace.go:172","msg":"trace[1052480392] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"277.086376ms","start":"2026-05-21T22:43:55.165865Z","end":"2026-05-21T22:43:55.442951Z","steps":["trace[1052480392] 'process raft request' (duration: 276.876181ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:55.448108Z","caller":"traceutil/trace.go:172","msg":"trace[840400720] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"260.147809ms","start":"2026-05-21T22:43:55.187929Z","end":"2026-05-21T22:43:55.448076Z","steps":["trace[840400720] 'process raft request' (duration: 259.204007ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:55.448258Z","caller":"traceutil/trace.go:172","msg":"trace[1108377543] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"254.70483ms","start":"2026-05-21T22:43:55.193546Z","end":"2026-05-21T22:43:55.448251Z","steps":["trace[1108377543] 'process raft request' (duration: 254.454574ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:55.448219Z","caller":"traceutil/trace.go:172","msg":"trace[1197065128] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"222.689148ms","start":"2026-05-21T22:43:55.225509Z","end":"2026-05-21T22:43:55.448198Z","steps":["trace[1197065128] 'process raft request' (duration: 222.554925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:56.136757Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475701,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:43:56.637929Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475701,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:43:56.735425Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.148054078s","expected-duration":"1s"} {"level":"info","ts":"2026-05-21T22:43:56.735671Z","caller":"traceutil/trace.go:172","msg":"trace[1421812116] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:565; }","duration":"1.09969658s","start":"2026-05-21T22:43:55.635949Z","end":"2026-05-21T22:43:56.735646Z","steps":["trace[1421812116] 'read index received' (duration: 1.0996862s)","trace[1421812116] 'applied index is now lower than readState.Index' (duration: 8.62µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:43:56.735846Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.099845503s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:43:56.735934Z","caller":"traceutil/trace.go:172","msg":"trace[1164398910] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:544; }","duration":"1.099970026s","start":"2026-05-21T22:43:55.635943Z","end":"2026-05-21T22:43:56.735913Z","steps":["trace[1164398910] 'agreement among raft nodes before linearized reading' (duration: 1.099798602s)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:56.736005Z","caller":"traceutil/trace.go:172","msg":"trace[80304199] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.148746743s","start":"2026-05-21T22:43:55.587244Z","end":"2026-05-21T22:43:56.735991Z","steps":["trace[80304199] 'process raft request' (duration: 1.148550218s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:56.736125Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:55.587221Z","time spent":"1.148820835s","remote":"127.0.0.1:33348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:43:56.832720Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"398.994509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:43:56.832824Z","caller":"traceutil/trace.go:172","msg":"trace[1010186487] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:545; }","duration":"399.108382ms","start":"2026-05-21T22:43:56.433694Z","end":"2026-05-21T22:43:56.832802Z","steps":["trace[1010186487] 'agreement among raft nodes before linearized reading' (duration: 396.365188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:56.832876Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:56.433673Z","time spent":"399.191414ms","remote":"127.0.0.1:33262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-21T22:43:56.832910Z","caller":"traceutil/trace.go:172","msg":"trace[1573064488] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.233405111s","start":"2026-05-21T22:43:55.599484Z","end":"2026-05-21T22:43:56.832889Z","steps":["trace[1573064488] 'process raft request' (duration: 1.230629846s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:56.833034Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:55.599453Z","time spent":"1.233530143s","remote":"127.0.0.1:33348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T22:43:56.833220Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"496.678883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-21T22:43:56.833537Z","caller":"traceutil/trace.go:172","msg":"trace[1555846073] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"503.516434ms","start":"2026-05-21T22:43:56.329981Z","end":"2026-05-21T22:43:56.833498Z","steps":["trace[1555846073] 'process raft request' (duration: 502.854259ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:56.833533Z","caller":"traceutil/trace.go:172","msg":"trace[622096402] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"502.615563ms","start":"2026-05-21T22:43:56.330903Z","end":"2026-05-21T22:43:56.833519Z","steps":["trace[622096402] 'process raft request' (duration: 502.544401ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:56.833536Z","caller":"traceutil/trace.go:172","msg":"trace[92637269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:545; }","duration":"496.992681ms","start":"2026-05-21T22:43:56.336527Z","end":"2026-05-21T22:43:56.833520Z","steps":["trace[92637269] 'agreement among raft nodes before linearized reading' (duration: 493.53844ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:43:56.833594Z","caller":"traceutil/trace.go:172","msg":"trace[2067698971] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"399.89078ms","start":"2026-05-21T22:43:56.433683Z","end":"2026-05-21T22:43:56.833574Z","steps":["trace[2067698971] 'process raft request' (duration: 399.808018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:56.833609Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:56.336515Z","time spent":"497.079153ms","remote":"127.0.0.1:33730","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":"warn","ts":"2026-05-21T22:43:56.833615Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:56.330870Z","time spent":"502.706865ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:43:56.833643Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:56.329953Z","time spent":"503.621006ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:43:56.833685Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:56.433659Z","time spent":"399.969022ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:43:56.833281Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"494.770119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-21T22:43:56.833732Z","caller":"traceutil/trace.go:172","msg":"trace[428813394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:545; }","duration":"495.452185ms","start":"2026-05-21T22:43:56.338267Z","end":"2026-05-21T22:43:56.833719Z","steps":["trace[428813394] 'agreement among raft nodes before linearized reading' (duration: 491.815599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:56.833775Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:43:56.338259Z","time spent":"495.502806ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:43:56.833390Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"166.021898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:43:56.833865Z","caller":"traceutil/trace.go:172","msg":"trace[2029236778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:545; }","duration":"166.471529ms","start":"2026-05-21T22:43:56.667336Z","end":"2026-05-21T22:43:56.833808Z","steps":["trace[2029236778] 'agreement among raft nodes before linearized reading' (duration: 162.70252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:43:56.841551Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"104.082714ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:43:56.841870Z","caller":"traceutil/trace.go:172","msg":"trace[20614568] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:549; }","duration":"104.404332ms","start":"2026-05-21T22:43:56.737455Z","end":"2026-05-21T22:43:56.841860Z","steps":["trace[20614568] 'agreement among raft nodes before linearized reading' (duration: 103.879079ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:00.595443Z","caller":"traceutil/trace.go:172","msg":"trace[188093872] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"215.131562ms","start":"2026-05-21T22:44:00.379239Z","end":"2026-05-21T22:44:00.594370Z","steps":["trace[188093872] 'process raft request' (duration: 214.760603ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:00.819631Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"155.701624ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-21T22:44:00.819737Z","caller":"traceutil/trace.go:172","msg":"trace[983265048] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"168.391591ms","start":"2026-05-21T22:44:00.651329Z","end":"2026-05-21T22:44:00.819720Z","steps":["trace[983265048] 'process raft request' (duration: 12.354559ms)","trace[983265048] 'compare' (duration: 155.556491ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:00.936159Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50862","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:00.958305Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50878","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:00.978473Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:00.998435Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50888","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.020270Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50900","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.042738Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50912","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.061506Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50938","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.081689Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50956","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.123185Z","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-05-21T22:44:01.238973Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51000","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.315542Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51040","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-21T22:44:01.392828Z","caller":"traceutil/trace.go:172","msg":"trace[701505414] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"100.492363ms","start":"2026-05-21T22:44:01.292311Z","end":"2026-05-21T22:44:01.392804Z","steps":["trace[701505414] 'process raft request' (duration: 98.131078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:01.423082Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51052","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.457408Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51084","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.510251Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51098","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.546937Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51122","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.569494Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51136","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.589578Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51142","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.616193Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"130.771019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:01.616243Z","caller":"traceutil/trace.go:172","msg":"trace[1004764169] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:589; }","duration":"130.83205ms","start":"2026-05-21T22:44:01.485403Z","end":"2026-05-21T22:44:01.616235Z","steps":["trace[1004764169] 'range keys from in-memory index tree' (duration: 130.709417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:01.639745Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51166","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.719753Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51198","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.760434Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51220","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.775371Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51232","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:01.788413Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51240","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-21T22:44:02.112202Z","caller":"traceutil/trace.go:172","msg":"trace[1652987957] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"103.956121ms","start":"2026-05-21T22:44:02.008218Z","end":"2026-05-21T22:44:02.112175Z","steps":["trace[1652987957] 'process raft request' (duration: 102.747972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:02.239602Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.56327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:02.239692Z","caller":"traceutil/trace.go:172","msg":"trace[1577086179] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies; range_end:; response_count:0; response_revision:590; }","duration":"109.667832ms","start":"2026-05-21T22:44:02.130010Z","end":"2026-05-21T22:44:02.239678Z","steps":["trace[1577086179] 'range keys from in-memory index tree' (duration: 109.479079ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:02.833320Z","caller":"traceutil/trace.go:172","msg":"trace[1793022208] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:613; }","duration":"102.342763ms","start":"2026-05-21T22:44:02.730945Z","end":"2026-05-21T22:44:02.833288Z","steps":["trace[1793022208] 'read index received' (duration: 102.334412ms)","trace[1793022208] 'applied index is now lower than readState.Index' (duration: 6.641µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:02.833579Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"102.603519ms","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-05-21T22:44:02.833623Z","caller":"traceutil/trace.go:172","msg":"trace[983232565] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies; range_end:; response_count:0; response_revision:591; }","duration":"102.690981ms","start":"2026-05-21T22:44:02.730921Z","end":"2026-05-21T22:44:02.833612Z","steps":["trace[983232565] 'agreement among raft nodes before linearized reading' (duration: 102.558408ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:02.837112Z","caller":"traceutil/trace.go:172","msg":"trace[128618313] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"159.760309ms","start":"2026-05-21T22:44:02.677340Z","end":"2026-05-21T22:44:02.837101Z","steps":["trace[128618313] 'process raft request' (duration: 156.188946ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:03.060154Z","caller":"traceutil/trace.go:172","msg":"trace[1682665959] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"143.869008ms","start":"2026-05-21T22:44:02.916258Z","end":"2026-05-21T22:44:03.060127Z","steps":["trace[1682665959] 'process raft request' (duration: 133.243601ms)","trace[1682665959] 'compare' (duration: 10.514475ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:03.495589Z","caller":"traceutil/trace.go:172","msg":"trace[1835852070] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"134.432595ms","start":"2026-05-21T22:44:03.361133Z","end":"2026-05-21T22:44:03.495566Z","steps":["trace[1835852070] 'process raft request' (duration: 133.847202ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:04.303949Z","caller":"traceutil/trace.go:172","msg":"trace[742947319] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:621; }","duration":"193.480063ms","start":"2026-05-21T22:44:04.110433Z","end":"2026-05-21T22:44:04.303913Z","steps":["trace[742947319] 'read index received' (duration: 193.465853ms)","trace[742947319] 'applied index is now lower than readState.Index' (duration: 12.6µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:04.304161Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"193.721718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-21T22:44:04.304230Z","caller":"traceutil/trace.go:172","msg":"trace[1302360272] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:599; }","duration":"193.801281ms","start":"2026-05-21T22:44:04.110416Z","end":"2026-05-21T22:44:04.304218Z","steps":["trace[1302360272] 'agreement among raft nodes before linearized reading' (duration: 193.560925ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:04.305432Z","caller":"traceutil/trace.go:172","msg":"trace[538241856] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"281.178989ms","start":"2026-05-21T22:44:04.024168Z","end":"2026-05-21T22:44:04.305347Z","steps":["trace[538241856] 'process raft request' (duration: 280.006972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:04.478287Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"126.398625ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T22:44:04.478452Z","caller":"traceutil/trace.go:172","msg":"trace[624267466] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"144.768572ms","start":"2026-05-21T22:44:04.333663Z","end":"2026-05-21T22:44:04.478432Z","steps":["trace[624267466] 'process raft request' (duration: 18.124641ms)","trace[624267466] 'compare' (duration: 126.19017ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:04.488248Z","caller":"traceutil/trace.go:172","msg":"trace[912603729] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"104.138418ms","start":"2026-05-21T22:44:04.383934Z","end":"2026-05-21T22:44:04.488073Z","steps":["trace[912603729] 'process raft request' (duration: 103.992815ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:05.197463Z","caller":"traceutil/trace.go:172","msg":"trace[530313745] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:628; }","duration":"235.978735ms","start":"2026-05-21T22:44:04.961454Z","end":"2026-05-21T22:44:05.197433Z","steps":["trace[530313745] 'read index received' (duration: 235.968024ms)","trace[530313745] 'applied index is now lower than readState.Index' (duration: 9.441µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:05.197753Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"236.280582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-21T22:44:05.197778Z","caller":"traceutil/trace.go:172","msg":"trace[176638721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:605; }","duration":"236.322732ms","start":"2026-05-21T22:44:04.961448Z","end":"2026-05-21T22:44:05.197771Z","steps":["trace[176638721] 'agreement among raft nodes before linearized reading' (duration: 236.145778ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:05.200331Z","caller":"traceutil/trace.go:172","msg":"trace[2038043278] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"313.020653ms","start":"2026-05-21T22:44:04.887294Z","end":"2026-05-21T22:44:05.200314Z","steps":["trace[2038043278] 'process raft request' (duration: 311.193781ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:05.205435Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:04.887262Z","time spent":"318.02678ms","remote":"127.0.0.1:33410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036325,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:44:05.698221Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475907,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:06.198874Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475907,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:06.469079Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.271654242s","expected-duration":"1s"} {"level":"info","ts":"2026-05-21T22:44:06.469356Z","caller":"traceutil/trace.go:172","msg":"trace[793121662] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:629; }","duration":"1.271748513s","start":"2026-05-21T22:44:05.197556Z","end":"2026-05-21T22:44:06.469305Z","steps":["trace[793121662] 'read index received' (duration: 1.271739483s)","trace[793121662] 'applied index is now lower than readState.Index' (duration: 7.52µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:06.970557Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475910,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:06.972559Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"304.125345ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:06.972609Z","caller":"traceutil/trace.go:172","msg":"trace[1157369512] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:606; }","duration":"304.192467ms","start":"2026-05-21T22:44:06.668404Z","end":"2026-05-21T22:44:06.972597Z","steps":["trace[1157369512] 'range keys from in-memory index tree' (duration: 304.079114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:06.972964Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.336627514s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:06.973038Z","caller":"traceutil/trace.go:172","msg":"trace[399525917] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:606; }","duration":"1.336723396s","start":"2026-05-21T22:44:05.636288Z","end":"2026-05-21T22:44:06.973012Z","steps":["trace[399525917] 'range keys from in-memory index tree' (duration: 1.336610943s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:06.974034Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.909040151s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-21T22:44:06.974119Z","caller":"traceutil/trace.go:172","msg":"trace[424365669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:606; }","duration":"1.909129123s","start":"2026-05-21T22:44:05.064967Z","end":"2026-05-21T22:44:06.974096Z","steps":["trace[424365669] 'agreement among raft nodes before linearized reading' (duration: 1.404510923s)","trace[424365669] 'range keys from in-memory index tree' (duration: 503.71993ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:06.974165Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:05.064950Z","time spent":"1.909200624s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:06.975578Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"505.950301ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T22:44:06.976041Z","caller":"traceutil/trace.go:172","msg":"trace[68540658] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"2.059665627s","start":"2026-05-21T22:44:04.916139Z","end":"2026-05-21T22:44:06.975804Z","steps":["trace[68540658] 'process raft request' (duration: 1.553384818s)","trace[68540658] 'compare' (duration: 502.732576ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:06.975993Z","caller":"traceutil/trace.go:172","msg":"trace[1245785161] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"1.813577747s","start":"2026-05-21T22:44:05.162403Z","end":"2026-05-21T22:44:06.975980Z","steps":["trace[1245785161] 'process raft request' (duration: 1.813485865s)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:06.976036Z","caller":"traceutil/trace.go:172","msg":"trace[66039164] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"2.059816781s","start":"2026-05-21T22:44:04.916196Z","end":"2026-05-21T22:44:06.976013Z","steps":["trace[66039164] 'process raft request' (duration: 2.059511084s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:06.976244Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:05.162373Z","time spent":"1.813789302s","remote":"127.0.0.1:33392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":692,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T22:44:06.976253Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:04.916113Z","time spent":"2.059999415s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:44:06.976404Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:04.916170Z","time spent":"2.060118727s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:44:07.471795Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475910,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:07.667674Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.999928561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-21T22:44:07.667782Z","caller":"traceutil/trace.go:172","msg":"trace[650031393] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000044354s","start":"2026-05-21T22:44:05.667714Z","end":"2026-05-21T22:44:07.667758Z","steps":["trace[650031393] 'agreement among raft nodes before linearized reading' (duration: 1.999926691s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:07.667874Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:05.667684Z","time spent":"2.000181138s","remote":"127.0.0.1:33248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/21 22:44:07 WARNING: [core] [Server #6]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-21T22:44:07.972095Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475910,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:08.325193Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.71213502s","expected-duration":"1s"} {"level":"info","ts":"2026-05-21T22:44:08.325416Z","caller":"traceutil/trace.go:172","msg":"trace[1512766690] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:632; }","duration":"1.855919351s","start":"2026-05-21T22:44:06.469442Z","end":"2026-05-21T22:44:08.325361Z","steps":["trace[1512766690] 'read index received' (duration: 1.855906681s)","trace[1512766690] 'applied index is now lower than readState.Index' (duration: 8.59µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:08.466690Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.708895531s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6gj8x\" limit:1 ","response":"range_response_count:1 size:18350"} {"level":"info","ts":"2026-05-21T22:44:08.466765Z","caller":"traceutil/trace.go:172","msg":"trace[1319320341] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6gj8x; range_end:; response_count:1; response_revision:609; }","duration":"2.708979023s","start":"2026-05-21T22:44:05.757766Z","end":"2026-05-21T22:44:08.466745Z","steps":["trace[1319320341] 'agreement among raft nodes before linearized reading' (duration: 2.567752598s)","trace[1319320341] 'range keys from in-memory index tree' (duration: 141.03356ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:08.466806Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:05.757747Z","time spent":"2.709049934s","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18374,"request content":"key:\"/registry/pods/kube-system/cilium-6gj8x\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:08.468013Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.035470633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:08.468109Z","caller":"traceutil/trace.go:172","msg":"trace[111764758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"2.035577605s","start":"2026-05-21T22:44:06.432507Z","end":"2026-05-21T22:44:08.468085Z","steps":["trace[111764758] 'agreement among raft nodes before linearized reading' (duration: 1.892919288s)","trace[111764758] 'range keys from in-memory index tree' (duration: 142.499664ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:08.468153Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:06.432484Z","time spent":"2.035659778s","remote":"127.0.0.1:33262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T22:44:08.481833Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"156.296844ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T22:44:08.482077Z","caller":"traceutil/trace.go:172","msg":"trace[773650495] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"3.276858703s","start":"2026-05-21T22:44:05.205196Z","end":"2026-05-21T22:44:08.482055Z","steps":["trace[773650495] 'process raft request' (duration: 3.120219872s)","trace[773650495] 'compare' (duration: 140.512718ms)","trace[773650495] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-system/plndr-svcs-lock; req_size:422; } (duration: 15.708033ms)"],"step_count":3} {"level":"warn","ts":"2026-05-21T22:44:08.482160Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:05.205156Z","time spent":"3.276950025s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T22:44:08.483093Z","caller":"traceutil/trace.go:172","msg":"trace[1586084614] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"3.21425541s","start":"2026-05-21T22:44:05.268823Z","end":"2026-05-21T22:44:08.483078Z","steps":["trace[1586084614] 'process raft request' (duration: 3.214100147s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:08.483176Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:05.268797Z","time spent":"3.214338763s","remote":"127.0.0.1:33690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2676,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T22:44:08.483363Z","caller":"traceutil/trace.go:172","msg":"trace[1918314796] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:632; }","duration":"157.873049ms","start":"2026-05-21T22:44:08.325475Z","end":"2026-05-21T22:44:08.483348Z","steps":["trace[1918314796] 'read index received' (duration: 72.69015ms)","trace[1918314796] 'applied index is now lower than readState.Index' (duration: 85.181539ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:08.483419Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"807.123224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:08.483450Z","caller":"traceutil/trace.go:172","msg":"trace[1030159107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"807.156125ms","start":"2026-05-21T22:44:07.676286Z","end":"2026-05-21T22:44:08.483442Z","steps":["trace[1030159107] 'agreement among raft nodes before linearized reading' (duration: 807.099633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:08.483471Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:07.676263Z","time spent":"807.203295ms","remote":"127.0.0.1:33262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-21T22:44:08.483569Z","caller":"traceutil/trace.go:172","msg":"trace[1085635294] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.501241127s","start":"2026-05-21T22:44:06.982314Z","end":"2026-05-21T22:44:08.483555Z","steps":["trace[1085635294] 'process raft request' (duration: 1.500702335s)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:08.483746Z","caller":"traceutil/trace.go:172","msg":"trace[1723391385] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.329174404s","start":"2026-05-21T22:44:07.154549Z","end":"2026-05-21T22:44:08.483724Z","steps":["trace[1723391385] 'process raft request' (duration: 1.328849667s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:08.483851Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:07.154526Z","time spent":"1.329259877s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":528,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T22:44:08.484012Z","caller":"traceutil/trace.go:172","msg":"trace[940119060] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"811.937586ms","start":"2026-05-21T22:44:07.672062Z","end":"2026-05-21T22:44:08.483999Z","steps":["trace[940119060] 'process raft request' (duration: 811.426254ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:08.484072Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:07.672040Z","time spent":"812.006087ms","remote":"127.0.0.1:33392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":769,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T22:44:08.483435Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.510348858s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:08.484154Z","caller":"traceutil/trace.go:172","msg":"trace[1959027892] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:612; }","duration":"1.511067265s","start":"2026-05-21T22:44:06.973075Z","end":"2026-05-21T22:44:08.484143Z","steps":["trace[1959027892] 'agreement among raft nodes before linearized reading' (duration: 1.510323808s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:08.483873Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:06.982288Z","time spent":"1.501550014s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:44:09.001481Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"364.806202ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:09.001554Z","caller":"traceutil/trace.go:172","msg":"trace[462854101] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:614; }","duration":"365.000007ms","start":"2026-05-21T22:44:08.636543Z","end":"2026-05-21T22:44:09.001543Z","steps":["trace[462854101] 'range keys from in-memory index tree' (duration: 364.787822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:09.003954Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475918,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-21T22:44:09.055202Z","caller":"traceutil/trace.go:172","msg":"trace[220790922] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:637; }","duration":"552.178593ms","start":"2026-05-21T22:44:08.503002Z","end":"2026-05-21T22:44:09.055180Z","steps":["trace[220790922] 'read index received' (duration: 552.171662ms)","trace[220790922] 'applied index is now lower than readState.Index' (duration: 5.581µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:09.055445Z","caller":"traceutil/trace.go:172","msg":"trace[960232037] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"553.83037ms","start":"2026-05-21T22:44:08.501603Z","end":"2026-05-21T22:44:09.055434Z","steps":["trace[960232037] 'process raft request' (duration: 553.717668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:09.055427Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"552.400908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" limit:1 ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-21T22:44:09.055536Z","caller":"traceutil/trace.go:172","msg":"trace[2023733023] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:614; }","duration":"552.52236ms","start":"2026-05-21T22:44:08.502999Z","end":"2026-05-21T22:44:09.055521Z","steps":["trace[2023733023] 'agreement among raft nodes before linearized reading' (duration: 552.262764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:09.055540Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:08.501588Z","time spent":"553.885882ms","remote":"127.0.0.1:33392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":768,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T22:44:09.055613Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:08.502992Z","time spent":"552.609472ms","remote":"127.0.0.1:33626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" limit:1 "} {"level":"info","ts":"2026-05-21T22:44:09.411256Z","caller":"traceutil/trace.go:172","msg":"trace[1757672900] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:638; }","duration":"355.958749ms","start":"2026-05-21T22:44:09.055259Z","end":"2026-05-21T22:44:09.411218Z","steps":["trace[1757672900] 'read index received' (duration: 355.950609ms)","trace[1757672900] 'applied index is now lower than readState.Index' (duration: 6.65µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:09.411549Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"409.935435ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:09.411979Z","caller":"traceutil/trace.go:172","msg":"trace[1010571852] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:615; }","duration":"410.378256ms","start":"2026-05-21T22:44:09.001581Z","end":"2026-05-21T22:44:09.411959Z","steps":["trace[1010571852] 'agreement among raft nodes before linearized reading' (duration: 409.877994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:09.412132Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"347.211907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:09.412249Z","caller":"traceutil/trace.go:172","msg":"trace[1089551988] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:618; }","duration":"347.33906ms","start":"2026-05-21T22:44:09.064893Z","end":"2026-05-21T22:44:09.412232Z","steps":["trace[1089551988] 'agreement among raft nodes before linearized reading' (duration: 347.177086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:09.412340Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:09.064871Z","time spent":"347.454493ms","remote":"127.0.0.1:33512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges\" limit:1 "} {"level":"info","ts":"2026-05-21T22:44:09.411802Z","caller":"traceutil/trace.go:172","msg":"trace[299790522] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"429.620401ms","start":"2026-05-21T22:44:08.982165Z","end":"2026-05-21T22:44:09.411786Z","steps":["trace[299790522] 'process raft request' (duration: 429.565249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:09.412531Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:08.982157Z","time spent":"430.310706ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T22:44:09.412610Z","caller":"traceutil/trace.go:172","msg":"trace[1154576902] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"430.541032ms","start":"2026-05-21T22:44:08.982049Z","end":"2026-05-21T22:44:09.412590Z","steps":["trace[1154576902] 'process raft request' (duration: 429.618211ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:09.412604Z","caller":"traceutil/trace.go:172","msg":"trace[94755024] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"909.023802ms","start":"2026-05-21T22:44:08.503303Z","end":"2026-05-21T22:44:09.412327Z","steps":["trace[94755024] 'process raft request' (duration: 908.207753ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:09.412733Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:08.982022Z","time spent":"430.643424ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:44:09.412900Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:08.503279Z","time spent":"909.484703ms","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18507,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:44:10.166130Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:10.667146Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:10.752051Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.334985155s","expected-duration":"1s"} {"level":"info","ts":"2026-05-21T22:44:10.752356Z","caller":"traceutil/trace.go:172","msg":"trace[1358827789] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:641; }","duration":"1.086972549s","start":"2026-05-21T22:44:09.665353Z","end":"2026-05-21T22:44:10.752325Z","steps":["trace[1358827789] 'read index received' (duration: 1.086958928s)","trace[1358827789] 'applied index is now lower than readState.Index' (duration: 11.811µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:11.252716Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:11.753740Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354475928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:12.102545Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.350213545s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-21T22:44:12.261518Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.596140633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:12.261612Z","caller":"traceutil/trace.go:172","msg":"trace[945746240] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"2.596242066s","start":"2026-05-21T22:44:09.665347Z","end":"2026-05-21T22:44:12.261589Z","steps":["trace[945746240] 'agreement among raft nodes before linearized reading' (duration: 1.087103562s)","trace[945746240] 'range keys from in-memory index tree' (duration: 1.508993881s)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:12.261650Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:09.665323Z","time spent":"2.596319378s","remote":"127.0.0.1:33262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T22:44:12.262742Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.626520855s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:12.262830Z","caller":"traceutil/trace.go:172","msg":"trace[1084762700] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:618; }","duration":"2.626622027s","start":"2026-05-21T22:44:09.636190Z","end":"2026-05-21T22:44:12.262812Z","steps":["trace[1084762700] 'range keys from in-memory index tree' (duration: 2.626451983s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:12.263259Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.510750722s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-21T22:44:12.263543Z","caller":"traceutil/trace.go:172","msg":"trace[802158537] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"2.846564685s","start":"2026-05-21T22:44:09.416949Z","end":"2026-05-21T22:44:12.263514Z","steps":["trace[802158537] 'process raft request' (duration: 1.335496767s)","trace[802158537] 'compare' (duration: 1.507533997s)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:12.263665Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:09.416929Z","time spent":"2.846678008s","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2738,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T22:44:12.263735Z","caller":"traceutil/trace.go:172","msg":"trace[1463522583] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"1.511299604s","start":"2026-05-21T22:44:10.752419Z","end":"2026-05-21T22:44:12.263719Z","steps":["trace[1463522583] 'read index received' (duration: 1.350273197s)","trace[1463522583] 'applied index is now lower than readState.Index' (duration: 161.024907ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:12.322825Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.821162448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-21T22:44:12.322851Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"657.053613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:12.322904Z","caller":"traceutil/trace.go:172","msg":"trace[601696774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"1.82125141s","start":"2026-05-21T22:44:10.501633Z","end":"2026-05-21T22:44:12.322885Z","steps":["trace[601696774] 'agreement among raft nodes before linearized reading' (duration: 1.762287873s)","trace[601696774] 'range keys from in-memory index tree' (duration: 58.743092ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:12.322948Z","caller":"traceutil/trace.go:172","msg":"trace[411579592] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"657.155996ms","start":"2026-05-21T22:44:11.665773Z","end":"2026-05-21T22:44:12.322929Z","steps":["trace[411579592] 'agreement among raft nodes before linearized reading' (duration: 657.025973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:12.322961Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:10.501614Z","time spent":"1.821338732s","remote":"127.0.0.1:33730","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-05-21T22:44:12.322992Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:11.665751Z","time spent":"657.233237ms","remote":"127.0.0.1:33248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T22:44:12.323493Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.821646019s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-21T22:44:12.323657Z","caller":"traceutil/trace.go:172","msg":"trace[1923582378] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"1.821812813s","start":"2026-05-21T22:44:10.501824Z","end":"2026-05-21T22:44:12.323637Z","steps":["trace[1923582378] 'agreement among raft nodes before linearized reading' (duration: 1.761917765s)","trace[1923582378] 'range keys from in-memory index tree' (duration: 59.54039ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:12.323782Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:10.501786Z","time spent":"1.821982177s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-05-21T22:44:12.324130Z","caller":"traceutil/trace.go:172","msg":"trace[789714070] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"906.205254ms","start":"2026-05-21T22:44:11.417803Z","end":"2026-05-21T22:44:12.324008Z","steps":["trace[789714070] 'process raft request' (duration: 905.790814ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:12.323877Z","caller":"traceutil/trace.go:172","msg":"trace[934316845] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"906.131902ms","start":"2026-05-21T22:44:11.417719Z","end":"2026-05-21T22:44:12.323851Z","steps":["trace[934316845] 'process raft request' (duration: 904.978085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:12.324385Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:11.417696Z","time spent":"906.602093ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:44:12.324663Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:11.417795Z","time spent":"906.384107ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T22:44:12.956412Z","caller":"traceutil/trace.go:172","msg":"trace[1614084483] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"133.689448ms","start":"2026-05-21T22:44:12.822699Z","end":"2026-05-21T22:44:12.956388Z","steps":["trace[1614084483] 'process raft request' (duration: 133.544144ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:14.439102Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:14.111351Z","time spent":"327.747079ms","remote":"127.0.0.1:33312","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-21T22:44:14.462298Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"118.778393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-21T22:44:14.462539Z","caller":"traceutil/trace.go:172","msg":"trace[1468979395] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"118.989308ms","start":"2026-05-21T22:44:14.343493Z","end":"2026-05-21T22:44:14.462482Z","steps":["trace[1468979395] 'agreement among raft nodes before linearized reading' (duration: 118.62372ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:14.462704Z","caller":"traceutil/trace.go:172","msg":"trace[1556932010] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"127.649725ms","start":"2026-05-21T22:44:14.335036Z","end":"2026-05-21T22:44:14.462686Z","steps":["trace[1556932010] 'process raft request' (duration: 127.607264ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:14.462818Z","caller":"traceutil/trace.go:172","msg":"trace[1931653342] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"128.720792ms","start":"2026-05-21T22:44:14.334071Z","end":"2026-05-21T22:44:14.462792Z","steps":["trace[1931653342] 'process raft request' (duration: 128.106147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:21.353886Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48660","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:24.052425Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48674","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:24.065666Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48706","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:24.164821Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48722","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:24.190964Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48748","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:24.353923Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48756","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-21T22:44:24.394620Z","caller":"traceutil/trace.go:172","msg":"trace[1509213885] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"135.932901ms","start":"2026-05-21T22:44:24.258655Z","end":"2026-05-21T22:44:24.394588Z","steps":["trace[1509213885] 'process raft request' (duration: 119.811188ms)","trace[1509213885] 'compare' (duration: 15.986389ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:24.465255Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48776","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:25.792015Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.583319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:25.792136Z","caller":"traceutil/trace.go:172","msg":"trace[543236898] range","detail":"{range_begin:/registry/configmaps; range_end:; response_count:0; response_revision:758; }","duration":"116.725864ms","start":"2026-05-21T22:44:25.675393Z","end":"2026-05-21T22:44:25.792119Z","steps":["trace[543236898] 'range keys from in-memory index tree' (duration: 116.506528ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:25.792189Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"118.393574ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T22:44:25.792200Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.766386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:25.792287Z","caller":"traceutil/trace.go:172","msg":"trace[2069657237] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:758; }","duration":"118.502027ms","start":"2026-05-21T22:44:25.673759Z","end":"2026-05-21T22:44:25.792261Z","steps":["trace[2069657237] 'range keys from in-memory index tree' (duration: 118.344602ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:25.792345Z","caller":"traceutil/trace.go:172","msg":"trace[413681594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:758; }","duration":"109.933621ms","start":"2026-05-21T22:44:25.682381Z","end":"2026-05-21T22:44:25.792315Z","steps":["trace[413681594] 'range keys from in-memory index tree' (duration: 109.673134ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:28.909903Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"241.715482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:28.910004Z","caller":"traceutil/trace.go:172","msg":"trace[55587598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"241.839486ms","start":"2026-05-21T22:44:28.668139Z","end":"2026-05-21T22:44:28.909979Z","steps":["trace[55587598] 'agreement among raft nodes before linearized reading' (duration: 111.757652ms)","trace[55587598] 'range keys from in-memory index tree' (duration: 129.890259ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:28.910124Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"291.171283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-21T22:44:28.910219Z","caller":"traceutil/trace.go:172","msg":"trace[18777944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:790; }","duration":"291.284227ms","start":"2026-05-21T22:44:28.618914Z","end":"2026-05-21T22:44:28.910198Z","steps":["trace[18777944] 'agreement among raft nodes before linearized reading' (duration: 160.956476ms)","trace[18777944] 'range keys from in-memory index tree' (duration: 130.055253ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:28.910451Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"274.624494ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:28.910565Z","caller":"traceutil/trace.go:172","msg":"trace[1986873986] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:790; }","duration":"274.741697ms","start":"2026-05-21T22:44:28.635794Z","end":"2026-05-21T22:44:28.910536Z","steps":["trace[1986873986] 'agreement among raft nodes before linearized reading' (duration: 144.114768ms)","trace[1986873986] 'range keys from in-memory index tree' (duration: 130.475635ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:28.910813Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"130.753184ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T22:44:28.911007Z","caller":"traceutil/trace.go:172","msg":"trace[401593812] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"291.299027ms","start":"2026-05-21T22:44:28.619687Z","end":"2026-05-21T22:44:28.910986Z","steps":["trace[401593812] 'process raft request' (duration: 160.284136ms)","trace[401593812] 'compare' (duration: 130.30906ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:28.911458Z","caller":"traceutil/trace.go:172","msg":"trace[29930246] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"198.128254ms","start":"2026-05-21T22:44:28.713316Z","end":"2026-05-21T22:44:28.911444Z","steps":["trace[29930246] 'process raft request' (duration: 197.574548ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:29.097596Z","caller":"traceutil/trace.go:172","msg":"trace[821692736] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"180.439173ms","start":"2026-05-21T22:44:28.917131Z","end":"2026-05-21T22:44:29.097570Z","steps":["trace[821692736] 'process raft request' (duration: 175.008493ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:29.349801Z","caller":"traceutil/trace.go:172","msg":"trace[1785864860] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"140.070374ms","start":"2026-05-21T22:44:29.209715Z","end":"2026-05-21T22:44:29.349786Z","steps":["trace[1785864860] 'process raft request' (duration: 105.61301ms)","trace[1785864860] 'compare' (duration: 33.863927ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:29.612987Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"105.256519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:29.613102Z","caller":"traceutil/trace.go:172","msg":"trace[734426751] range","detail":"{range_begin:/registry/replicasets; range_end:; response_count:0; response_revision:795; }","duration":"105.370503ms","start":"2026-05-21T22:44:29.507691Z","end":"2026-05-21T22:44:29.613062Z","steps":["trace[734426751] 'range keys from in-memory index tree' (duration: 105.062854ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:31.217678Z","caller":"traceutil/trace.go:172","msg":"trace[460406232] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:826; }","duration":"115.973723ms","start":"2026-05-21T22:44:31.101679Z","end":"2026-05-21T22:44:31.217653Z","steps":["trace[460406232] 'read index received' (duration: 115.966643ms)","trace[460406232] 'applied index is now lower than readState.Index' (duration: 6.15µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:31.217891Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.20236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-21T22:44:31.217928Z","caller":"traceutil/trace.go:172","msg":"trace[2077715475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:796; }","duration":"116.255231ms","start":"2026-05-21T22:44:31.101663Z","end":"2026-05-21T22:44:31.217918Z","steps":["trace[2077715475] 'agreement among raft nodes before linearized reading' (duration: 116.086876ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:31.218564Z","caller":"traceutil/trace.go:172","msg":"trace[1912649817] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"301.402686ms","start":"2026-05-21T22:44:30.917140Z","end":"2026-05-21T22:44:31.218543Z","steps":["trace[1912649817] 'process raft request' (duration: 301.057836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:31.218734Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:30.917112Z","time spent":"301.540551ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T22:44:31.230839Z","caller":"traceutil/trace.go:172","msg":"trace[551632214] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"311.080859ms","start":"2026-05-21T22:44:30.919733Z","end":"2026-05-21T22:44:31.230814Z","steps":["trace[551632214] 'process raft request' (duration: 310.914065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:31.231012Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:30.919704Z","time spent":"311.223234ms","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:44:32.874938Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53900","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:32.885983Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53908","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:32.900775Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53950","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:32.913221Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53962","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-21T22:44:34.343876Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"431.198196ms","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-05-21T22:44:34.344054Z","caller":"traceutil/trace.go:172","msg":"trace[266714252] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools; range_end:; response_count:0; response_revision:814; }","duration":"431.406442ms","start":"2026-05-21T22:44:33.912594Z","end":"2026-05-21T22:44:34.344001Z","steps":["trace[266714252] 'range keys from in-memory index tree' (duration: 431.079902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:34.344142Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:33.912570Z","time spent":"431.524765ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:34.344140Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"686.214239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:34.344216Z","caller":"traceutil/trace.go:172","msg":"trace[761803855] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:814; }","duration":"686.303071ms","start":"2026-05-21T22:44:33.657897Z","end":"2026-05-21T22:44:34.344200Z","steps":["trace[761803855] 'range keys from in-memory index tree' (duration: 686.115146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:34.344254Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:33.657868Z","time spent":"686.376944ms","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/pods\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:34.344277Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"677.99419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:34.344323Z","caller":"traceutil/trace.go:172","msg":"trace[121180819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"678.054092ms","start":"2026-05-21T22:44:33.666256Z","end":"2026-05-21T22:44:34.344310Z","steps":["trace[121180819] 'range keys from in-memory index tree' (duration: 677.848466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:34.344369Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:33.666233Z","time spent":"678.127324ms","remote":"127.0.0.1:33262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T22:44:34.344435Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"421.277687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T22:44:34.344500Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"458.876561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T22:44:34.344496Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"496.621057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T22:44:34.344624Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"586.973404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:34.344680Z","caller":"traceutil/trace.go:172","msg":"trace[1554500295] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:814; }","duration":"587.029886ms","start":"2026-05-21T22:44:33.757640Z","end":"2026-05-21T22:44:34.344670Z","steps":["trace[1554500295] 'range keys from in-memory index tree' (duration: 586.858191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:34.344712Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:33.757610Z","time spent":"587.095648ms","remote":"127.0.0.1:33606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/pods\" limit:1 "} {"level":"info","ts":"2026-05-21T22:44:34.344588Z","caller":"traceutil/trace.go:172","msg":"trace[988320189] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs; range_end:; response_count:0; response_revision:814; }","duration":"458.964303ms","start":"2026-05-21T22:44:33.885607Z","end":"2026-05-21T22:44:34.344571Z","steps":["trace[988320189] 'range keys from in-memory index tree' (duration: 458.759627ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:34.344755Z","caller":"traceutil/trace.go:172","msg":"trace[437853663] range","detail":"{range_begin:/registry/csidrivers; range_end:; response_count:0; response_revision:814; }","duration":"496.808502ms","start":"2026-05-21T22:44:33.847845Z","end":"2026-05-21T22:44:34.344653Z","steps":["trace[437853663] 'range keys from in-memory index tree' (duration: 496.506364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:34.344803Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:33.885579Z","time spent":"459.205189ms","remote":"127.0.0.1:53886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:34.344616Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"445.160651ms","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-05-21T22:44:34.345213Z","caller":"traceutil/trace.go:172","msg":"trace[2017918289] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads; range_end:; response_count:0; response_revision:814; }","duration":"445.753018ms","start":"2026-05-21T22:44:33.899447Z","end":"2026-05-21T22:44:34.345200Z","steps":["trace[2017918289] 'range keys from in-memory index tree' (duration: 445.046548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:34.345252Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:33.899423Z","time spent":"445.81679ms","remote":"127.0.0.1:53924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads\" limit:1 "} {"level":"info","ts":"2026-05-21T22:44:34.344527Z","caller":"traceutil/trace.go:172","msg":"trace[327359739] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies; range_end:; response_count:0; response_revision:814; }","duration":"421.38413ms","start":"2026-05-21T22:44:33.923125Z","end":"2026-05-21T22:44:34.344509Z","steps":["trace[327359739] 'range keys from in-memory index tree' (duration: 421.197125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:34.345436Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:33.923110Z","time spent":"422.317137ms","remote":"127.0.0.1:53974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:34.345660Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:33.847794Z","time spent":"497.847483ms","remote":"127.0.0.1:34064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":29,"request content":"key:\"/registry/csidrivers\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:34.612107Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354476340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:35.112775Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354476340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:35.613736Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354476340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:36.114374Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354476340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:36.346670Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000381714s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-21T22:44:36.346766Z","caller":"traceutil/trace.go:172","msg":"trace[185000207] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000513798s","start":"2026-05-21T22:44:34.346223Z","end":"2026-05-21T22:44:36.346736Z","steps":["trace[185000207] 'agreement among raft nodes before linearized reading' (duration: 2.000376204s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:36.346830Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:34.346203Z","time spent":"2.000617181s","remote":"127.0.0.1:33248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T22:44:36.614762Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726426354476340,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T22:44:36.882298Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.813059313s","expected-duration":"1s"} {"level":"info","ts":"2026-05-21T22:44:36.882576Z","caller":"traceutil/trace.go:172","msg":"trace[110674282] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:844; }","duration":"2.77089663s","start":"2026-05-21T22:44:34.111648Z","end":"2026-05-21T22:44:36.882545Z","steps":["trace[110674282] 'read index received' (duration: 2.770869979s)","trace[110674282] 'applied index is now lower than readState.Index' (duration: 25.261µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:36.882711Z","caller":"traceutil/trace.go:172","msg":"trace[998473105] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"2.829234491s","start":"2026-05-21T22:44:34.053466Z","end":"2026-05-21T22:44:36.882701Z","steps":["trace[998473105] 'process raft request' (duration: 2.829119608s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:36.882809Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:34.053436Z","time spent":"2.829313043s","remote":"127.0.0.1:33690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2879,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:44:36.882971Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.77124689s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-21T22:44:36.883086Z","caller":"traceutil/trace.go:172","msg":"trace[718038452] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:815; }","duration":"2.771425125s","start":"2026-05-21T22:44:34.111641Z","end":"2026-05-21T22:44:36.883067Z","steps":["trace[718038452] 'agreement among raft nodes before linearized reading' (duration: 2.771011463s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:36.883140Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:34.111618Z","time spent":"2.771508038s","remote":"127.0.0.1:33312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.138\" limit:1 "} {"level":"info","ts":"2026-05-21T22:44:37.367151Z","caller":"traceutil/trace.go:172","msg":"trace[347879751] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:845; }","duration":"484.465543ms","start":"2026-05-21T22:44:36.882657Z","end":"2026-05-21T22:44:37.367123Z","steps":["trace[347879751] 'read index received' (duration: 484.450673ms)","trace[347879751] 'applied index is now lower than readState.Index' (duration: 13.11µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.388719Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.797464657s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/servicecidrs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T22:44:37.388787Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.035915486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:37.388848Z","caller":"traceutil/trace.go:172","msg":"trace[2082030587] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:815; }","duration":"1.035962978s","start":"2026-05-21T22:44:36.352864Z","end":"2026-05-21T22:44:37.388827Z","steps":["trace[2082030587] 'agreement among raft nodes before linearized reading' (duration: 1.014383768s)","trace[2082030587] 'range keys from in-memory index tree' (duration: 21.521118ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.388901Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:36.352857Z","time spent":"1.036031079s","remote":"127.0.0.1:33262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T22:44:37.389046Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.869768327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-21T22:44:37.389110Z","caller":"traceutil/trace.go:172","msg":"trace[556629924] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:815; }","duration":"1.869827139s","start":"2026-05-21T22:44:35.519262Z","end":"2026-05-21T22:44:37.389090Z","steps":["trace[556629924] 'agreement among raft nodes before linearized reading' (duration: 1.848013112s)","trace[556629924] 'range keys from in-memory index tree' (duration: 21.651092ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.389222Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.83141248s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:37.389299Z","caller":"traceutil/trace.go:172","msg":"trace[603122174] range","detail":"{range_begin:/registry/ingressclasses; range_end:; response_count:0; response_revision:815; }","duration":"1.831486172s","start":"2026-05-21T22:44:35.557799Z","end":"2026-05-21T22:44:37.389285Z","steps":["trace[603122174] 'agreement among raft nodes before linearized reading' (duration: 1.809467049s)","trace[603122174] 'range keys from in-memory index tree' (duration: 21.93038ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:37.388834Z","caller":"traceutil/trace.go:172","msg":"trace[443900845] range","detail":"{range_begin:/registry/servicecidrs; range_end:; response_count:0; response_revision:815; }","duration":"2.797565429s","start":"2026-05-21T22:44:34.591226Z","end":"2026-05-21T22:44:37.388791Z","steps":["trace[443900845] 'agreement among raft nodes before linearized reading' (duration: 2.77600276s)","trace[443900845] 'range keys from in-memory index tree' (duration: 21.410015ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.389353Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:34.591201Z","time spent":"2.798135366s","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":29,"request content":"key:\"/registry/servicecidrs\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:37.389329Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:35.557767Z","time spent":"1.831552824s","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":29,"request content":"key:\"/registry/ingressclasses\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:37.388733Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.096199049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T22:44:37.389916Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.957914184s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:37.390045Z","caller":"traceutil/trace.go:172","msg":"trace[499275030] range","detail":"{range_begin:/registry/validatingwebhookconfigurations; range_end:; response_count:0; response_revision:815; }","duration":"1.958051988s","start":"2026-05-21T22:44:35.431970Z","end":"2026-05-21T22:44:37.390022Z","steps":["trace[499275030] 'agreement among raft nodes before linearized reading' (duration: 1.935238272s)","trace[499275030] 'range keys from in-memory index tree' (duration: 22.64187ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.390145Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:35.431942Z","time spent":"1.958185502s","remote":"127.0.0.1:34234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/validatingwebhookconfigurations\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:37.390298Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"846.699015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:37.390353Z","caller":"traceutil/trace.go:172","msg":"trace[2051492731] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:815; }","duration":"846.750687ms","start":"2026-05-21T22:44:36.543587Z","end":"2026-05-21T22:44:37.390338Z","steps":["trace[2051492731] 'agreement among raft nodes before linearized reading' (duration: 823.650813ms)","trace[2051492731] 'range keys from in-memory index tree' (duration: 23.035012ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.390384Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:36.543558Z","time spent":"846.816859ms","remote":"127.0.0.1:33950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":33,"response count":0,"response size":29,"request content":"key:\"/registry/clusterrolebindings\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:37.390306Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.085102469s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-21T22:44:37.390559Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.754154841s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:37.390577Z","caller":"traceutil/trace.go:172","msg":"trace[1071789093] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:815; }","duration":"2.085362816s","start":"2026-05-21T22:44:35.305189Z","end":"2026-05-21T22:44:37.390552Z","steps":["trace[1071789093] 'agreement among raft nodes before linearized reading' (duration: 2.062073347s)","trace[1071789093] 'range keys from in-memory index tree' (duration: 22.96822ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.390626Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.54637878s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicybindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T22:44:37.390646Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:35.305181Z","time spent":"2.085449178s","remote":"127.0.0.1:33730","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":"warn","ts":"2026-05-21T22:44:37.390708Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.709983851s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T22:44:37.390335Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.040109926s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-controller.18b1b6020a6fb211\" limit:1 ","response":"range_response_count:1 size:784"} {"level":"info","ts":"2026-05-21T22:44:37.390734Z","caller":"traceutil/trace.go:172","msg":"trace[232736111] range","detail":"{range_begin:/registry/clusterroles; range_end:; response_count:0; response_revision:815; }","duration":"2.710035022s","start":"2026-05-21T22:44:34.680690Z","end":"2026-05-21T22:44:37.390725Z","steps":["trace[232736111] 'agreement among raft nodes before linearized reading' (duration: 2.686596079s)","trace[232736111] 'range keys from in-memory index tree' (duration: 23.378401ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:37.390742Z","caller":"traceutil/trace.go:172","msg":"trace[348950878] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-controller.18b1b6020a6fb211; range_end:; response_count:1; response_revision:815; }","duration":"1.040520898s","start":"2026-05-21T22:44:36.350210Z","end":"2026-05-21T22:44:37.390730Z","steps":["trace[348950878] 'agreement among raft nodes before linearized reading' (duration: 1.017047764s)","trace[348950878] 'range keys from in-memory index tree' (duration: 22.306371ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.390762Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:34.680659Z","time spent":"2.710094984s","remote":"127.0.0.1:33932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":29,"request content":"key:\"/registry/clusterroles\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:37.390812Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.083723569s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-21T22:44:37.390597Z","caller":"traceutil/trace.go:172","msg":"trace[788645173] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:815; }","duration":"2.754188232s","start":"2026-05-21T22:44:34.636395Z","end":"2026-05-21T22:44:37.390583Z","steps":["trace[788645173] 'agreement among raft nodes before linearized reading' (duration: 2.730896003s)","trace[788645173] 'range keys from in-memory index tree' (duration: 23.250248ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:37.390874Z","caller":"traceutil/trace.go:172","msg":"trace[1875091717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:815; }","duration":"2.084018358s","start":"2026-05-21T22:44:35.306828Z","end":"2026-05-21T22:44:37.390846Z","steps":["trace[1875091717] 'agreement among raft nodes before linearized reading' (duration: 2.06042497s)","trace[1875091717] 'range keys from in-memory index tree' (duration: 21.910159ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.390909Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:35.306814Z","time spent":"2.084085399s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-05-21T22:44:37.390651Z","caller":"traceutil/trace.go:172","msg":"trace[1706891351] range","detail":"{range_begin:/registry/validatingadmissionpolicybindings; range_end:; response_count:0; response_revision:815; }","duration":"2.546402121s","start":"2026-05-21T22:44:34.844240Z","end":"2026-05-21T22:44:37.390642Z","steps":["trace[1706891351] 'agreement among raft nodes before linearized reading' (duration: 2.5230411s)","trace[1706891351] 'range keys from in-memory index tree' (duration: 23.32819ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.391063Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:34.844211Z","time spent":"2.546840973s","remote":"127.0.0.1:34284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":29,"request content":"key:\"/registry/validatingadmissionpolicybindings\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:37.390766Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:36.350184Z","time spent":"1.04057388s","remote":"127.0.0.1:33392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":808,"request content":"key:\"/registry/events/kube-system/kube-apiserver-controller.18b1b6020a6fb211\" limit:1 "} {"level":"info","ts":"2026-05-21T22:44:37.391917Z","caller":"traceutil/trace.go:172","msg":"trace[300941229] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"2.652580847s","start":"2026-05-21T22:44:34.739321Z","end":"2026-05-21T22:44:37.391902Z","steps":["trace[300941229] 'process raft request' (duration: 2.628041122s)","trace[300941229] 'compare' (duration: 24.03873ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.392017Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:34.739304Z","time spent":"2.652653839s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T22:44:37.392097Z","caller":"traceutil/trace.go:172","msg":"trace[1501221318] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"2.109064691s","start":"2026-05-21T22:44:35.283023Z","end":"2026-05-21T22:44:37.392088Z","steps":["trace[1501221318] 'process raft request' (duration: 2.108481394s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:37.392144Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:35.282996Z","time spent":"2.109124993s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T22:44:37.392208Z","caller":"traceutil/trace.go:172","msg":"trace[416715684] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"1.576765411s","start":"2026-05-21T22:44:35.815435Z","end":"2026-05-21T22:44:37.392200Z","steps":["trace[416715684] 'process raft request' (duration: 1.576110233s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T22:44:37.392147Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:35.519224Z","time spent":"1.869910081s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-05-21T22:44:37.392254Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:35.815393Z","time spent":"1.576835493s","remote":"127.0.0.1:33730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T22:44:37.392336Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:36.884234Z","time spent":"508.100761ms","remote":"127.0.0.1:33312","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-21T22:44:37.389602Z","caller":"traceutil/trace.go:172","msg":"trace[681187635] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices; range_end:; response_count:0; response_revision:815; }","duration":"2.097070844s","start":"2026-05-21T22:44:35.292515Z","end":"2026-05-21T22:44:37.389586Z","steps":["trace[681187635] 'agreement among raft nodes before linearized reading' (duration: 2.074756113s)","trace[681187635] 'range keys from in-memory index tree' (duration: 21.423766ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:37.392409Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:35.292493Z","time spent":"2.099897326s","remote":"127.0.0.1:34382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 "} {"level":"info","ts":"2026-05-21T22:44:38.062042Z","caller":"traceutil/trace.go:172","msg":"trace[1226442739] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"123.882873ms","start":"2026-05-21T22:44:37.938131Z","end":"2026-05-21T22:44:38.062014Z","steps":["trace[1226442739] 'process raft request' (duration: 123.695567ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:40.241402Z","caller":"traceutil/trace.go:172","msg":"trace[1111541101] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"117.350461ms","start":"2026-05-21T22:44:40.123992Z","end":"2026-05-21T22:44:40.241342Z","steps":["trace[1111541101] 'process raft request' (duration: 116.731553ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:40.241626Z","caller":"traceutil/trace.go:172","msg":"trace[1260083530] transaction","detail":"{read_only:false; response_revision:838; number_of_response:1; }","duration":"115.881339ms","start":"2026-05-21T22:44:40.125718Z","end":"2026-05-21T22:44:40.241599Z","steps":["trace[1260083530] 'process raft request' (duration: 115.706114ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:44:40.635207Z","caller":"traceutil/trace.go:172","msg":"trace[1508984890] linearizableReadLoop","detail":"{readStateIndex:871; appliedIndex:871; }","duration":"103.29728ms","start":"2026-05-21T22:44:40.531881Z","end":"2026-05-21T22:44:40.635179Z","steps":["trace[1508984890] 'read index received' (duration: 103.28573ms)","trace[1508984890] 'applied index is now lower than readState.Index' (duration: 9.8µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:40.686616Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"154.709004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:44:40.686837Z","caller":"traceutil/trace.go:172","msg":"trace[853458239] range","detail":"{range_begin:/registry/validatingadmissionpolicies; range_end:; response_count:0; response_revision:839; }","duration":"154.90291ms","start":"2026-05-21T22:44:40.531868Z","end":"2026-05-21T22:44:40.686771Z","steps":["trace[853458239] 'agreement among raft nodes before linearized reading' (duration: 103.381683ms)","trace[853458239] 'range keys from in-memory index tree' (duration: 51.300541ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:44:40.686831Z","caller":"traceutil/trace.go:172","msg":"trace[1602755198] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"349.652374ms","start":"2026-05-21T22:44:40.337148Z","end":"2026-05-21T22:44:40.686801Z","steps":["trace[1602755198] 'process raft request' (duration: 298.069456ms)","trace[1602755198] 'compare' (duration: 51.197567ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:44:40.686970Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-21T22:44:40.337125Z","time spent":"349.777967ms","remote":"127.0.0.1:33932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1929,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T22:45:01.793817Z","caller":"traceutil/trace.go:172","msg":"trace[1267406211] linearizableReadLoop","detail":"{readStateIndex:986; appliedIndex:986; }","duration":"157.644218ms","start":"2026-05-21T22:45:01.636148Z","end":"2026-05-21T22:45:01.793792Z","steps":["trace[1267406211] 'read index received' (duration: 157.632758ms)","trace[1267406211] 'applied index is now lower than readState.Index' (duration: 9.75µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:45:01.814504Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"178.342846ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:45:01.814592Z","caller":"traceutil/trace.go:172","msg":"trace[92721094] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:950; }","duration":"178.446939ms","start":"2026-05-21T22:45:01.636127Z","end":"2026-05-21T22:45:01.814574Z","steps":["trace[92721094] 'agreement among raft nodes before linearized reading' (duration: 157.75991ms)","trace[92721094] 'range keys from in-memory index tree' (duration: 20.559755ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:45:01.815349Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"178.521841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:45:01.815493Z","caller":"traceutil/trace.go:172","msg":"trace[2138511202] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"222.689884ms","start":"2026-05-21T22:45:01.592776Z","end":"2026-05-21T22:45:01.815466Z","steps":["trace[2138511202] 'process raft request' (duration: 201.030169ms)","trace[2138511202] 'compare' (duration: 21.043958ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:45:01.815553Z","caller":"traceutil/trace.go:172","msg":"trace[1721338699] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"220.904477ms","start":"2026-05-21T22:45:01.594613Z","end":"2026-05-21T22:45:01.815517Z","steps":["trace[1721338699] 'process raft request' (duration: 220.396113ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:45:01.815641Z","caller":"traceutil/trace.go:172","msg":"trace[973898639] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes; range_end:; response_count:0; response_revision:952; }","duration":"178.778918ms","start":"2026-05-21T22:45:01.636808Z","end":"2026-05-21T22:45:01.815587Z","steps":["trace[973898639] 'agreement among raft nodes before linearized reading' (duration: 178.449079ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:45:33.796668Z","caller":"traceutil/trace.go:172","msg":"trace[2054378287] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1099; }","duration":"100.717451ms","start":"2026-05-21T22:45:33.695881Z","end":"2026-05-21T22:45:33.796598Z","steps":["trace[2054378287] 'read index received' (duration: 100.711661ms)","trace[2054378287] 'applied index is now lower than readState.Index' (duration: 4.88µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T22:45:33.797642Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.727737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T22:45:33.797747Z","caller":"traceutil/trace.go:172","msg":"trace[116220203] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1057; }","duration":"101.84978ms","start":"2026-05-21T22:45:33.695876Z","end":"2026-05-21T22:45:33.797726Z","steps":["trace[116220203] 'agreement among raft nodes before linearized reading' (duration: 100.832234ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:45:33.797895Z","caller":"traceutil/trace.go:172","msg":"trace[1451948225] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"147.983849ms","start":"2026-05-21T22:45:33.649882Z","end":"2026-05-21T22:45:33.797866Z","steps":["trace[1451948225] 'process raft request' (duration: 146.698516ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T22:45:56.416927Z","caller":"traceutil/trace.go:172","msg":"trace[49491364] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"183.316575ms","start":"2026-05-21T22:45:56.233590Z","end":"2026-05-21T22:45:56.416906Z","steps":["trace[49491364] 'process raft request' (duration: 103.01084ms)","trace[49491364] 'compare' (duration: 80.007128ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T22:45:56.416937Z","caller":"traceutil/trace.go:172","msg":"trace[416500455] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"172.366783ms","start":"2026-05-21T22:45:56.244544Z","end":"2026-05-21T22:45:56.416911Z","steps":["trace[416500455] 'process raft request' (duration: 172.304942ms)"],"step_count":1}