{"level":"warn","ts":"2026-05-13T01:03:39.201483Z","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-13T01:03:39.202212Z","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-13T01:03:39.202232Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=controller=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-13T01:03:39.202517Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-05-13T01:03:39.202570Z","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-13T01:03:39.202582Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-13T01:03:39.202654Z","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-13T01:03:39.203124Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-05-13T01:03:39.203277Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.204.45.72: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-13T01:03:39.207860Z","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: 0xc000416ef0}"} {"level":"info","ts":"2026-05-13T01:03:39.212083Z","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-13T01:03:39.212127Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.358952ms"} {"level":"info","ts":"2026-05-13T01:03:39.212158Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-05-13T01:03:39.212203Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-05-13T01:03:39.212290Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-05-13T01:03:39.217758Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-05-13T01:03:39.217872Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-05-13T01:03:39.217896Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-05-13T01:03:39.217982Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-05-13T01:03:39.218013Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-05-13T01:03:39.218077Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-13T01:03:39.218116Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-05-13T01:03:39.218206Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-05-13T01:03:39.225647Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-13T01:03:39.228408Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-13T01:03:39.230548Z","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-13T01:03:39.231017Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-13T01:03:39.231216Z","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-13T01:03:39.231194Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-13T01:03:39.231239Z","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-13T01:03:39.231301Z","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-13T01:03:39.231316Z","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-13T01:03:39.231383Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-13T01:03:39.231429Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-13T01:03:39.231609Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-13T01:03:39.231669Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-13T01:03:39.231813Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-05-13T01:03:39.231902Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-05-13T01:03:39.619035Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-05-13T01:03:39.619097Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-05-13T01:03:39.619168Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-05-13T01:03:39.619196Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"50e03cebfd94cbba has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-13T01:03:39.619227Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-05-13T01:03:39.749291Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-13T01:03:39.749382Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"50e03cebfd94cbba has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-13T01:03:39.749434Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-05-13T01:03:39.749595Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-13T01:03:39.764469Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:controller ClientURLs:[https://199.204.45.72:2379]}","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-05-13T01:03:39.764904Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-13T01:03:39.765172Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-13T01:03:39.765165Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-05-13T01:03:39.765862Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-13T01:03:39.765968Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-13T01:03:39.767007Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-05-13T01:03:39.771414Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-05-13T01:03:39.771490Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-05-13T01:03:39.793744Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-13T01:03:39.793809Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-05-13T01:03:39.831710Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.6"} {"level":"info","ts":"2026-05-13T01:03:39.841684Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-05-13T01:03:39.841791Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-05-13T01:03:39.841856Z","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-13T01:03:39.841935Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"warn","ts":"2026-05-13T01:03:40.305652Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38046","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.309576Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38060","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.325132Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38074","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.332212Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38100","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.349033Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38130","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.375491Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38154","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.379186Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38184","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.384700Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38188","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.395153Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38212","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.404296Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38224","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.411760Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38238","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.421174Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38248","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.430508Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38262","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.438969Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38282","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.450907Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38302","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.460548Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38322","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.473188Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38346","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.481984Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38364","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.490016Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38384","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.499965Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38396","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.513799Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38416","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.547455Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38430","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.558666Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38442","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.567492Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38450","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.585237Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38494","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.591263Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38538","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.599700Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38540","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.608467Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38552","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.617995Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38558","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.627117Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38576","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.635058Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38610","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.644304Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38618","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.655464Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38634","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.664205Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38678","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.671643Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38692","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.679680Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38716","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.689145Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38748","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.709079Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38756","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.712107Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38780","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.719564Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38812","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.738639Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38834","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.746900Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38864","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.754721Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38872","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.764538Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38886","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.790643Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38912","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.801620Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38918","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.819914Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38938","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.829492Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38956","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.838940Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38984","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.851458Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:38988","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.861034Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39004","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.868493Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39028","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.877045Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39038","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.885971Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39052","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.893301Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39068","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.921344Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39074","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.929452Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39092","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.938104Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39106","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:03:40.989848Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39124","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-13T01:03:41.551613Z","caller":"traceutil/trace.go:172","msg":"trace[639479169] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:6; }","duration":"104.434982ms","start":"2026-05-13T01:03:41.447146Z","end":"2026-05-13T01:03:41.551581Z","steps":["trace[639479169] 'read index received' (duration: 104.428581ms)","trace[639479169] 'applied index is now lower than readState.Index' (duration: 5.051µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:03:41.632539Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"185.326316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-13T01:03:41.632676Z","caller":"traceutil/trace.go:172","msg":"trace[777817306] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"206.119003ms","start":"2026-05-13T01:03:41.426541Z","end":"2026-05-13T01:03:41.632660Z","steps":["trace[777817306] 'process raft request' (duration: 125.177336ms)","trace[777817306] 'compare' (duration: 80.721227ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:03:41.632807Z","caller":"traceutil/trace.go:172","msg":"trace[1678950255] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"205.59423ms","start":"2026-05-13T01:03:41.427203Z","end":"2026-05-13T01:03:41.632798Z","steps":["trace[1678950255] 'process raft request' (duration: 205.519716ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:41.632785Z","caller":"traceutil/trace.go:172","msg":"trace[1551565321] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"206.039ms","start":"2026-05-13T01:03:41.426687Z","end":"2026-05-13T01:03:41.632726Z","steps":["trace[1551565321] 'process raft request' (duration: 205.936955ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:41.632810Z","caller":"traceutil/trace.go:172","msg":"trace[4670016] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"205.729966ms","start":"2026-05-13T01:03:41.427037Z","end":"2026-05-13T01:03:41.632767Z","steps":["trace[4670016] 'process raft request' (duration: 205.631762ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:41.632952Z","caller":"traceutil/trace.go:172","msg":"trace[1795749733] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"205.947435ms","start":"2026-05-13T01:03:41.426995Z","end":"2026-05-13T01:03:41.632943Z","steps":["trace[1795749733] 'process raft request' (duration: 205.703764ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:41.632960Z","caller":"traceutil/trace.go:172","msg":"trace[234179317] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"184.50538ms","start":"2026-05-13T01:03:41.448437Z","end":"2026-05-13T01:03:41.632943Z","steps":["trace[234179317] 'process raft request' (duration: 184.478019ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:41.633088Z","caller":"traceutil/trace.go:172","msg":"trace[1497491774] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"193.33981ms","start":"2026-05-13T01:03:41.439735Z","end":"2026-05-13T01:03:41.633075Z","steps":["trace[1497491774] 'process raft request' (duration: 193.092649ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:41.633153Z","caller":"traceutil/trace.go:172","msg":"trace[218458957] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"205.818649ms","start":"2026-05-13T01:03:41.427325Z","end":"2026-05-13T01:03:41.633144Z","steps":["trace[218458957] 'process raft request' (duration: 205.424802ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:41.633244Z","caller":"traceutil/trace.go:172","msg":"trace[687878430] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"190.685403ms","start":"2026-05-13T01:03:41.442548Z","end":"2026-05-13T01:03:41.633233Z","steps":["trace[687878430] 'process raft request' (duration: 190.334457ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:41.633267Z","caller":"traceutil/trace.go:172","msg":"trace[124519680] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"205.811169ms","start":"2026-05-13T01:03:41.427447Z","end":"2026-05-13T01:03:41.633259Z","steps":["trace[124519680] 'process raft request' (duration: 205.331668ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:41.633314Z","caller":"traceutil/trace.go:172","msg":"trace[1124055395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3; }","duration":"185.491524ms","start":"2026-05-13T01:03:41.447141Z","end":"2026-05-13T01:03:41.632633Z","steps":["trace[1124055395] 'agreement among raft nodes before linearized reading' (duration: 104.583238ms)","trace[1124055395] 'range keys from in-memory index tree' (duration: 80.711777ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:03:41.633360Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"155.883029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-13T01:03:41.633391Z","caller":"traceutil/trace.go:172","msg":"trace[1489372382] transaction","detail":"{read_only:false; number_of_response:0; response_revision:10; }","duration":"205.651071ms","start":"2026-05-13T01:03:41.427732Z","end":"2026-05-13T01:03:41.633383Z","steps":["trace[1489372382] 'process raft request' (duration: 205.077446ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:41.633419Z","caller":"traceutil/trace.go:172","msg":"trace[302057449] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:13; }","duration":"155.956802ms","start":"2026-05-13T01:03:41.477448Z","end":"2026-05-13T01:03:41.633405Z","steps":["trace[302057449] 'agreement among raft nodes before linearized reading' (duration: 155.824076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:03:41.633513Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"169.09779ms","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-13T01:03:41.633560Z","caller":"traceutil/trace.go:172","msg":"trace[1221999089] range","detail":"{range_begin:/registry/csinodes/controller; range_end:; response_count:0; response_revision:13; }","duration":"169.164664ms","start":"2026-05-13T01:03:41.464380Z","end":"2026-05-13T01:03:41.633545Z","steps":["trace[1221999089] 'agreement among raft nodes before linearized reading' (duration: 169.047319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:03:51.971997Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"104.475255ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-13T01:03:51.972867Z","caller":"traceutil/trace.go:172","msg":"trace[883634275] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"238.623585ms","start":"2026-05-13T01:03:51.734225Z","end":"2026-05-13T01:03:51.972849Z","steps":["trace[883634275] 'process raft request' (duration: 238.553682ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:03:51.972874Z","caller":"traceutil/trace.go:172","msg":"trace[2089969272] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"255.554814ms","start":"2026-05-13T01:03:51.717291Z","end":"2026-05-13T01:03:51.972846Z","steps":["trace[2089969272] 'process raft request' (duration: 149.510968ms)","trace[2089969272] 'compare' (duration: 104.316748ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:03:52.638376Z","caller":"traceutil/trace.go:172","msg":"trace[1468560027] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"525.243278ms","start":"2026-05-13T01:03:52.113104Z","end":"2026-05-13T01:03:52.638347Z","steps":["trace[1468560027] 'process raft request' (duration: 520.039439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:03:52.638740Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:03:52.113083Z","time spent":"525.427565ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":674,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:03:52.640424Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:03:52.118828Z","time spent":"521.584098ms","remote":"127.0.0.1:39064","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-13T01:03:58.275223Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"336.959796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:03:58.275336Z","caller":"traceutil/trace.go:172","msg":"trace[1691417729] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"282.872098ms","start":"2026-05-13T01:03:57.992445Z","end":"2026-05-13T01:03:58.275317Z","steps":["trace[1691417729] 'process raft request' (duration: 255.083514ms)","trace[1691417729] 'compare' (duration: 27.66447ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:03:58.275813Z","caller":"traceutil/trace.go:172","msg":"trace[2130807078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:433; }","duration":"337.170543ms","start":"2026-05-13T01:03:57.938229Z","end":"2026-05-13T01:03:58.275400Z","steps":["trace[2130807078] 'range keys from in-memory index tree' (duration: 336.894074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:03:58.276139Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:03:57.938208Z","time spent":"337.91939ms","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T01:03:58.587718Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"164.421969ms","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-13T01:03:58.587826Z","caller":"traceutil/trace.go:172","msg":"trace[1482526207] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:435; }","duration":"164.554724ms","start":"2026-05-13T01:03:58.423249Z","end":"2026-05-13T01:03:58.587804Z","steps":["trace[1482526207] 'range keys from in-memory index tree' (duration: 164.308396ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:03:58.588376Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"156.470806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-13T01:03:58.588981Z","caller":"traceutil/trace.go:172","msg":"trace[1409909830] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"237.956489ms","start":"2026-05-13T01:03:58.350994Z","end":"2026-05-13T01:03:58.588950Z","steps":["trace[1409909830] 'process raft request' (duration: 80.811539ms)","trace[1409909830] 'compare' (duration: 155.984968ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:02.560489Z","caller":"traceutil/trace.go:172","msg":"trace[1714305198] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"112.01881ms","start":"2026-05-13T01:04:02.448442Z","end":"2026-05-13T01:04:02.560461Z","steps":["trace[1714305198] 'process raft request' (duration: 18.721178ms)","trace[1714305198] 'compare' (duration: 93.033173ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:03.017074Z","caller":"traceutil/trace.go:172","msg":"trace[1109706557] linearizableReadLoop","detail":"{readStateIndex:465; appliedIndex:465; }","duration":"123.268898ms","start":"2026-05-13T01:04:02.893775Z","end":"2026-05-13T01:04:03.017044Z","steps":["trace[1109706557] 'read index received' (duration: 123.237597ms)","trace[1109706557] 'applied index is now lower than readState.Index' (duration: 29.321µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:03.627929Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963211,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:04.128732Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963211,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:04.577192Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.560124711s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-13T01:04:04.591270Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.697441937s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-13T01:04:04.591319Z","caller":"traceutil/trace.go:172","msg":"trace[1615742544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:448; }","duration":"1.69752625s","start":"2026-05-13T01:04:02.893772Z","end":"2026-05-13T01:04:04.591298Z","steps":["trace[1615742544] 'agreement among raft nodes before linearized reading' (duration: 123.381111ms)","trace[1615742544] 'range keys from in-memory index tree' (duration: 1.573929301s)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:04.591366Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:02.893756Z","time spent":"1.697602983s","remote":"127.0.0.1:38510","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-13T01:04:04.591463Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.574253362s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-13T01:04:04.591805Z","caller":"traceutil/trace.go:172","msg":"trace[842071682] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"2.142263326s","start":"2026-05-13T01:04:02.449513Z","end":"2026-05-13T01:04:04.591776Z","steps":["trace[842071682] 'process raft request' (duration: 2.142073409s)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:04.591932Z","caller":"traceutil/trace.go:172","msg":"trace[1899642817] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:465; }","duration":"1.464327096s","start":"2026-05-13T01:04:03.127576Z","end":"2026-05-13T01:04:04.591903Z","steps":["trace[1899642817] 'read index received' (duration: 1.449903755s)","trace[1899642817] 'applied index is now lower than readState.Index' (duration: 14.421211ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:04.591955Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:02.449488Z","time spent":"2.14239329s","remote":"127.0.0.1:38370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3848,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T01:04:04.592070Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.464490921s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-13T01:04:04.592134Z","caller":"traceutil/trace.go:172","msg":"trace[740739939] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:450; }","duration":"1.464556533s","start":"2026-05-13T01:04:03.127565Z","end":"2026-05-13T01:04:04.592122Z","steps":["trace[740739939] 'agreement among raft nodes before linearized reading' (duration: 1.464404808s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:04.592169Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:03.127540Z","time spent":"1.464621245s","remote":"127.0.0.1:38092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.72\" limit:1 "} {"level":"warn","ts":"2026-05-13T01:04:04.592673Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.305352928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:04:04.592727Z","caller":"traceutil/trace.go:172","msg":"trace[546998858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:453; }","duration":"1.30540546s","start":"2026-05-13T01:04:03.287311Z","end":"2026-05-13T01:04:04.592717Z","steps":["trace[546998858] 'agreement among raft nodes before linearized reading' (duration: 1.305334137s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:04.592751Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:03.287275Z","time spent":"1.305470482s","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-13T01:04:04.592851Z","caller":"traceutil/trace.go:172","msg":"trace[1222502708] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"1.826258829s","start":"2026-05-13T01:04:02.766575Z","end":"2026-05-13T01:04:04.592834Z","steps":["trace[1222502708] 'process raft request' (duration: 1.82595852s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:04.592977Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:02.766545Z","time spent":"1.826345672s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:04:04.593047Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.16983667s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T01:04:04.593065Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"878.536132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-13T01:04:04.593088Z","caller":"traceutil/trace.go:172","msg":"trace[128497524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:453; }","duration":"878.559363ms","start":"2026-05-13T01:04:03.714522Z","end":"2026-05-13T01:04:04.593081Z","steps":["trace[128497524] 'agreement among raft nodes before linearized reading' (duration: 878.48467ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:04.593083Z","caller":"traceutil/trace.go:172","msg":"trace[687601788] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:453; }","duration":"1.169874281s","start":"2026-05-13T01:04:03.423199Z","end":"2026-05-13T01:04:04.593073Z","steps":["trace[687601788] 'agreement among raft nodes before linearized reading' (duration: 1.16982275s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:04.593106Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:03.714501Z","time spent":"878.601604ms","remote":"127.0.0.1:38510","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-13T01:04:04.593163Z","caller":"traceutil/trace.go:172","msg":"trace[761355266] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"213.317217ms","start":"2026-05-13T01:04:04.379839Z","end":"2026-05-13T01:04:04.593156Z","steps":["trace[761355266] 'process raft request' (duration: 212.745908ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:04.593204Z","caller":"traceutil/trace.go:172","msg":"trace[1082350041] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"1.857315348s","start":"2026-05-13T01:04:02.735837Z","end":"2026-05-13T01:04:04.593153Z","steps":["trace[1082350041] 'process raft request' (duration: 1.856091067s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:04.593322Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:02.735810Z","time spent":"1.857454673s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:04.591645Z","caller":"traceutil/trace.go:172","msg":"trace[1817383007] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"2.142200094s","start":"2026-05-13T01:04:02.449407Z","end":"2026-05-13T01:04:04.591608Z","steps":["trace[1817383007] 'process raft request' (duration: 567.703144ms)","trace[1817383007] 'compare' (duration: 1.574099737s)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:04.594048Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:02.449381Z","time spent":"2.144566763s","remote":"127.0.0.1:38924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:04:04.759195Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"119.859994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-66bc5c9577-gddr4\" limit:1 ","response":"range_response_count:1 size:4357"} {"level":"info","ts":"2026-05-13T01:04:04.759303Z","caller":"traceutil/trace.go:172","msg":"trace[1252748415] range","detail":"{range_begin:/registry/pods/kube-system/coredns-66bc5c9577-gddr4; range_end:; response_count:1; response_revision:461; }","duration":"119.982668ms","start":"2026-05-13T01:04:04.639291Z","end":"2026-05-13T01:04:04.759273Z","steps":["trace[1252748415] 'agreement among raft nodes before linearized reading' (duration: 59.547955ms)","trace[1252748415] 'range keys from in-memory index tree' (duration: 60.147213ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:04.759370Z","caller":"traceutil/trace.go:172","msg":"trace[770631240] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"115.733805ms","start":"2026-05-13T01:04:04.643610Z","end":"2026-05-13T01:04:04.759344Z","steps":["trace[770631240] 'process raft request' (duration: 115.622692ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:04.759371Z","caller":"traceutil/trace.go:172","msg":"trace[998455183] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"116.946466ms","start":"2026-05-13T01:04:04.642392Z","end":"2026-05-13T01:04:04.759338Z","steps":["trace[998455183] 'process raft request' (duration: 56.431731ms)","trace[998455183] 'compare' (duration: 60.239266ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:04.759615Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"115.496547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" limit:1 ","response":"range_response_count:1 size:4477"} {"level":"info","ts":"2026-05-13T01:04:04.759710Z","caller":"traceutil/trace.go:172","msg":"trace[97608013] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:461; }","duration":"115.933232ms","start":"2026-05-13T01:04:04.643760Z","end":"2026-05-13T01:04:04.759693Z","steps":["trace[97608013] 'agreement among raft nodes before linearized reading' (duration: 55.065575ms)","trace[97608013] 'range keys from in-memory index tree' (duration: 60.215696ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:04.956163Z","caller":"traceutil/trace.go:172","msg":"trace[1542067842] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:482; }","duration":"131.46659ms","start":"2026-05-13T01:04:04.824651Z","end":"2026-05-13T01:04:04.956118Z","steps":["trace[1542067842] 'read index received' (duration: 131.453059ms)","trace[1542067842] 'applied index is now lower than readState.Index' (duration: 10.811µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:04.962593Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"137.912305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" limit:1 ","response":"range_response_count:1 size:475"} {"level":"info","ts":"2026-05-13T01:04:04.962655Z","caller":"traceutil/trace.go:172","msg":"trace[1678796695] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:464; }","duration":"137.991068ms","start":"2026-05-13T01:04:04.824647Z","end":"2026-05-13T01:04:04.962638Z","steps":["trace[1678796695] 'agreement among raft nodes before linearized reading' (duration: 131.591764ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:04.962759Z","caller":"traceutil/trace.go:172","msg":"trace[1229770540] transaction","detail":"{read_only:false; number_of_response:1; response_revision:466; }","duration":"137.388097ms","start":"2026-05-13T01:04:04.825357Z","end":"2026-05-13T01:04:04.962745Z","steps":["trace[1229770540] 'process raft request' (duration: 137.324635ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:04.962794Z","caller":"traceutil/trace.go:172","msg":"trace[314627479] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"193.764085ms","start":"2026-05-13T01:04:04.769015Z","end":"2026-05-13T01:04:04.962780Z","steps":["trace[314627479] 'process raft request' (duration: 187.210416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:05.170729Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"115.975428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-66bc5c9577\" limit:1 ","response":"range_response_count:1 size:4101"} {"level":"info","ts":"2026-05-13T01:04:05.170851Z","caller":"traceutil/trace.go:172","msg":"trace[1654744435] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-66bc5c9577; range_end:; response_count:1; response_revision:471; }","duration":"116.126593ms","start":"2026-05-13T01:04:05.054698Z","end":"2026-05-13T01:04:05.170825Z","steps":["trace[1654744435] 'agreement among raft nodes before linearized reading' (duration: 25.334584ms)","trace[1654744435] 'range keys from in-memory index tree' (duration: 90.557591ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:05.170981Z","caller":"traceutil/trace.go:172","msg":"trace[877862309] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"122.788164ms","start":"2026-05-13T01:04:05.048147Z","end":"2026-05-13T01:04:05.170935Z","steps":["trace[877862309] 'process raft request' (duration: 31.961994ms)","trace[877862309] 'compare' (duration: 90.667375ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:05.172375Z","caller":"traceutil/trace.go:172","msg":"trace[159208231] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"115.120511ms","start":"2026-05-13T01:04:05.057234Z","end":"2026-05-13T01:04:05.172354Z","steps":["trace[159208231] 'process raft request' (duration: 115.069889ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:05.172470Z","caller":"traceutil/trace.go:172","msg":"trace[1673779023] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"117.813049ms","start":"2026-05-13T01:04:05.054641Z","end":"2026-05-13T01:04:05.172454Z","steps":["trace[1673779023] 'process raft request' (duration: 117.557431ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:05.172765Z","caller":"traceutil/trace.go:172","msg":"trace[1422630502] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"117.456188ms","start":"2026-05-13T01:04:05.055300Z","end":"2026-05-13T01:04:05.172757Z","steps":["trace[1422630502] 'process raft request' (duration: 116.959892ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:05.172772Z","caller":"traceutil/trace.go:172","msg":"trace[1236129338] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"120.926552ms","start":"2026-05-13T01:04:05.051830Z","end":"2026-05-13T01:04:05.172757Z","steps":["trace[1236129338] 'process raft request' (duration: 120.208078ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:05.173099Z","caller":"traceutil/trace.go:172","msg":"trace[1935526955] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"120.945213ms","start":"2026-05-13T01:04:05.052138Z","end":"2026-05-13T01:04:05.173084Z","steps":["trace[1935526955] 'process raft request' (duration: 120.026263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:05.421375Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"131.776369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-13T01:04:05.421474Z","caller":"traceutil/trace.go:172","msg":"trace[1655418682] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"174.668803ms","start":"2026-05-13T01:04:05.246790Z","end":"2026-05-13T01:04:05.421459Z","steps":["trace[1655418682] 'process raft request' (duration: 42.742987ms)","trace[1655418682] 'compare' (duration: 131.656346ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:06.068705Z","caller":"traceutil/trace.go:172","msg":"trace[1128222085] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"631.15037ms","start":"2026-05-13T01:04:05.437526Z","end":"2026-05-13T01:04:06.068676Z","steps":["trace[1128222085] 'process raft request' (duration: 560.841438ms)","trace[1128222085] 'compare' (duration: 70.090313ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:06.068872Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:05.437507Z","time spent":"631.294955ms","remote":"127.0.0.1:38924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:08.857228Z","caller":"traceutil/trace.go:172","msg":"trace[1094981170] linearizableReadLoop","detail":"{readStateIndex:504; appliedIndex:504; }","duration":"121.900378ms","start":"2026-05-13T01:04:08.735272Z","end":"2026-05-13T01:04:08.857173Z","steps":["trace[1094981170] 'read index received' (duration: 121.888838ms)","trace[1094981170] 'applied index is now lower than readState.Index' (duration: 9.71µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:08.857501Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"122.205998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-13T01:04:08.857530Z","caller":"traceutil/trace.go:172","msg":"trace[747785556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:485; }","duration":"122.254379ms","start":"2026-05-13T01:04:08.735267Z","end":"2026-05-13T01:04:08.857521Z","steps":["trace[747785556] 'agreement among raft nodes before linearized reading' (duration: 122.097594ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:08.857584Z","caller":"traceutil/trace.go:172","msg":"trace[69936221] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"227.898799ms","start":"2026-05-13T01:04:08.629667Z","end":"2026-05-13T01:04:08.857566Z","steps":["trace[69936221] 'process raft request' (duration: 227.775976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:09.089893Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"354.531407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-13T01:04:09.089973Z","caller":"traceutil/trace.go:172","msg":"trace[1368549112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:486; }","duration":"354.62716ms","start":"2026-05-13T01:04:08.735327Z","end":"2026-05-13T01:04:09.089954Z","steps":["trace[1368549112] 'agreement among raft nodes before linearized reading' (duration: 184.385305ms)","trace[1368549112] 'range keys from in-memory index tree' (duration: 170.031118ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:09.090008Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:08.735320Z","time spent":"354.680692ms","remote":"127.0.0.1:38510","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-13T01:04:09.090025Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"170.013187ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-13T01:04:09.090222Z","caller":"traceutil/trace.go:172","msg":"trace[545245970] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"416.5435ms","start":"2026-05-13T01:04:08.673666Z","end":"2026-05-13T01:04:09.090209Z","steps":["trace[545245970] 'process raft request' (duration: 246.230823ms)","trace[545245970] 'compare' (duration: 169.832372ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:09.090260Z","caller":"traceutil/trace.go:172","msg":"trace[900264800] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"208.14354ms","start":"2026-05-13T01:04:08.882096Z","end":"2026-05-13T01:04:09.090240Z","steps":["trace[900264800] 'process raft request' (duration: 208.036916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:09.090301Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:08.673638Z","time spent":"416.619632ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:04:14.787572Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:15.092011Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.248029684s","expected-duration":"1s"} {"level":"info","ts":"2026-05-13T01:04:15.092670Z","caller":"traceutil/trace.go:172","msg":"trace[1877051757] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:518; }","duration":"805.944439ms","start":"2026-05-13T01:04:14.286708Z","end":"2026-05-13T01:04:15.092652Z","steps":["trace[1877051757] 'read index received' (duration: 805.938559ms)","trace[1877051757] 'applied index is now lower than readState.Index' (duration: 4.61µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:15.093259Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"806.537866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:04:15.093715Z","caller":"traceutil/trace.go:172","msg":"trace[634658623] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"1.25059424s","start":"2026-05-13T01:04:13.843086Z","end":"2026-05-13T01:04:15.093680Z","steps":["trace[634658623] 'process raft request' (duration: 1.249462187s)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:15.093734Z","caller":"traceutil/trace.go:172","msg":"trace[567331109] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:498; }","duration":"807.01506ms","start":"2026-05-13T01:04:14.286691Z","end":"2026-05-13T01:04:15.093706Z","steps":["trace[567331109] 'agreement among raft nodes before linearized reading' (duration: 806.462004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:15.093837Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:13.843046Z","time spent":"1.250733084s","remote":"127.0.0.1:38194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317280,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-13T01:04:15.093804Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:14.286666Z","time spent":"807.120963ms","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-13T01:04:15.299087Z","caller":"traceutil/trace.go:172","msg":"trace[163977174] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:519; }","duration":"205.435159ms","start":"2026-05-13T01:04:15.093615Z","end":"2026-05-13T01:04:15.299050Z","steps":["trace[163977174] 'read index received' (duration: 205.420679ms)","trace[163977174] 'applied index is now lower than readState.Index' (duration: 12.39µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:15.334159Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"910.309732ms","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-13T01:04:15.334225Z","caller":"traceutil/trace.go:172","msg":"trace[857498380] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:499; }","duration":"910.393034ms","start":"2026-05-13T01:04:14.423814Z","end":"2026-05-13T01:04:15.334208Z","steps":["trace[857498380] 'agreement among raft nodes before linearized reading' (duration: 875.322114ms)","trace[857498380] 'range keys from in-memory index tree' (duration: 34.964267ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:15.334729Z","caller":"traceutil/trace.go:172","msg":"trace[1115332020] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"416.544142ms","start":"2026-05-13T01:04:14.918153Z","end":"2026-05-13T01:04:15.334698Z","steps":["trace[1115332020] 'process raft request' (duration: 416.361177ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:15.334847Z","caller":"traceutil/trace.go:172","msg":"trace[545623077] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"124.432537ms","start":"2026-05-13T01:04:15.210339Z","end":"2026-05-13T01:04:15.334771Z","steps":["trace[545623077] 'process raft request' (duration: 124.387696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:15.335050Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:14.918134Z","time spent":"416.681736ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:04:15.335308Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"124.17063ms","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-13T01:04:15.335309Z","caller":"traceutil/trace.go:172","msg":"trace[310726105] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"219.262915ms","start":"2026-05-13T01:04:15.116022Z","end":"2026-05-13T01:04:15.335285Z","steps":["trace[310726105] 'process raft request' (duration: 218.648978ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:15.335357Z","caller":"traceutil/trace.go:172","msg":"trace[1541836671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:504; }","duration":"124.217181ms","start":"2026-05-13T01:04:15.211125Z","end":"2026-05-13T01:04:15.335342Z","steps":["trace[1541836671] 'agreement among raft nodes before linearized reading' (duration: 124.122118ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:15.335451Z","caller":"traceutil/trace.go:172","msg":"trace[2128011698] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"677.496519ms","start":"2026-05-13T01:04:14.657937Z","end":"2026-05-13T01:04:15.335434Z","steps":["trace[2128011698] 'process raft request' (duration: 641.236344ms)","trace[2128011698] 'compare' (duration: 34.835353ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:15.335554Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:14.657896Z","time spent":"677.582982ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:04:15.334925Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"236.882113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:04:15.335684Z","caller":"traceutil/trace.go:172","msg":"trace[741319617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:504; }","duration":"237.656327ms","start":"2026-05-13T01:04:15.098018Z","end":"2026-05-13T01:04:15.335675Z","steps":["trace[741319617] 'agreement among raft nodes before linearized reading' (duration: 236.846902ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:15.335790Z","caller":"traceutil/trace.go:172","msg":"trace[390003675] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"220.462622ms","start":"2026-05-13T01:04:15.115282Z","end":"2026-05-13T01:04:15.335744Z","steps":["trace[390003675] 'process raft request' (duration: 219.349828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:15.998716Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"232.353811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:04:15.998852Z","caller":"traceutil/trace.go:172","msg":"trace[1510073517] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:537; }","duration":"232.539817ms","start":"2026-05-13T01:04:15.766281Z","end":"2026-05-13T01:04:15.998821Z","steps":["trace[1510073517] 'range keys from in-memory index tree' (duration: 232.271479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:15.998840Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"139.182971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" limit:1 ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-05-13T01:04:15.998916Z","caller":"traceutil/trace.go:172","msg":"trace[131925994] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:537; }","duration":"139.281714ms","start":"2026-05-13T01:04:15.859615Z","end":"2026-05-13T01:04:15.998897Z","steps":["trace[131925994] 'range keys from in-memory index tree' (duration: 139.009526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:15.999335Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"238.847342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" limit:1 ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-05-13T01:04:15.999475Z","caller":"traceutil/trace.go:172","msg":"trace[533264899] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:537; }","duration":"238.943424ms","start":"2026-05-13T01:04:15.760452Z","end":"2026-05-13T01:04:15.999396Z","steps":["trace[533264899] 'range keys from in-memory index tree' (duration: 238.314906ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:18.787016Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963418,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:19.208427Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.345206982s","expected-duration":"1s"} {"level":"info","ts":"2026-05-13T01:04:19.208620Z","caller":"traceutil/trace.go:172","msg":"trace[753141844] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:611; }","duration":"921.720093ms","start":"2026-05-13T01:04:18.286868Z","end":"2026-05-13T01:04:19.208588Z","steps":["trace[753141844] 'read index received' (duration: 921.705863ms)","trace[753141844] 'applied index is now lower than readState.Index' (duration: 12.18µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:19.212733Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"925.84658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:04:19.212830Z","caller":"traceutil/trace.go:172","msg":"trace[1171203194] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"925.954983ms","start":"2026-05-13T01:04:18.286854Z","end":"2026-05-13T01:04:19.212809Z","steps":["trace[1171203194] 'agreement among raft nodes before linearized reading' (duration: 921.862757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:19.212884Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:18.286834Z","time spent":"926.039335ms","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T01:04:19.213307Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"790.057337ms","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-13T01:04:19.213385Z","caller":"traceutil/trace.go:172","msg":"trace[1592300810] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:586; }","duration":"790.147439ms","start":"2026-05-13T01:04:18.423219Z","end":"2026-05-13T01:04:19.213366Z","steps":["trace[1592300810] 'range keys from in-memory index tree' (duration: 789.880222ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:19.213986Z","caller":"traceutil/trace.go:172","msg":"trace[1907072025] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"1.350874611s","start":"2026-05-13T01:04:17.863079Z","end":"2026-05-13T01:04:19.213953Z","steps":["trace[1907072025] 'process raft request' (duration: 1.345623774s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:19.214199Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:17.863056Z","time spent":"1.351030076s","remote":"127.0.0.1:38132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:19.219472Z","caller":"traceutil/trace.go:172","msg":"trace[1440704475] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"1.339997955s","start":"2026-05-13T01:04:17.879442Z","end":"2026-05-13T01:04:19.219440Z","steps":["trace[1440704475] 'process raft request' (duration: 1.339722007s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:19.219555Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:17.879419Z","time spent":"1.340102308s","remote":"127.0.0.1:38132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-13T01:04:19.219453Z","caller":"traceutil/trace.go:172","msg":"trace[619132991] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"1.349399166s","start":"2026-05-13T01:04:17.870027Z","end":"2026-05-13T01:04:19.219426Z","steps":["trace[619132991] 'process raft request' (duration: 1.348921413s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:19.219784Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:17.870003Z","time spent":"1.349683345s","remote":"127.0.0.1:38132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:04:19.553384Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54978","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.572724Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55002","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.587804Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55020","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.625989Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55022","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.656157Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55062","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.713282Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55076","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.736492Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55086","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.757239Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55108","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.773071Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55118","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.797960Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55144","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.818697Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55146","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.842261Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55162","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.867883Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55204","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:19.878506Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55230","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-13T01:04:20.115300Z","caller":"traceutil/trace.go:172","msg":"trace[35056836] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"127.260096ms","start":"2026-05-13T01:04:19.988018Z","end":"2026-05-13T01:04:20.115278Z","steps":["trace[35056836] 'process raft request' (duration: 126.896316ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:20.175470Z","caller":"traceutil/trace.go:172","msg":"trace[569618331] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"139.452471ms","start":"2026-05-13T01:04:20.036003Z","end":"2026-05-13T01:04:20.175455Z","steps":["trace[569618331] 'process raft request' (duration: 139.370349ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:20.175577Z","caller":"traceutil/trace.go:172","msg":"trace[121720441] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"175.707551ms","start":"2026-05-13T01:04:19.999807Z","end":"2026-05-13T01:04:20.175514Z","steps":["trace[121720441] 'process raft request' (duration: 175.406733ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:23.153910Z","caller":"traceutil/trace.go:172","msg":"trace[542042494] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"111.859005ms","start":"2026-05-13T01:04:23.042008Z","end":"2026-05-13T01:04:23.153867Z","steps":["trace[542042494] 'process raft request' (duration: 12.432746ms)","trace[542042494] 'compare' (duration: 99.257114ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:24.285425Z","caller":"traceutil/trace.go:172","msg":"trace[1331409623] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"119.27041ms","start":"2026-05-13T01:04:24.166136Z","end":"2026-05-13T01:04:24.285406Z","steps":["trace[1331409623] 'process raft request' (duration: 118.820798ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:24.469427Z","caller":"traceutil/trace.go:172","msg":"trace[1290935165] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"122.99161ms","start":"2026-05-13T01:04:24.346411Z","end":"2026-05-13T01:04:24.469403Z","steps":["trace[1290935165] 'process raft request' (duration: 95.355393ms)","trace[1290935165] 'compare' (duration: 27.234956ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:25.130896Z","caller":"traceutil/trace.go:172","msg":"trace[1137460753] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"257.922241ms","start":"2026-05-13T01:04:24.872950Z","end":"2026-05-13T01:04:25.130872Z","steps":["trace[1137460753] 'process raft request' (duration: 257.319215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:25.751852Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"160.521575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-13T01:04:25.751914Z","caller":"traceutil/trace.go:172","msg":"trace[526801384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"160.615108ms","start":"2026-05-13T01:04:25.591289Z","end":"2026-05-13T01:04:25.751904Z","steps":["trace[526801384] 'agreement among raft nodes before linearized reading' (duration: 160.361001ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:25.751541Z","caller":"traceutil/trace.go:172","msg":"trace[1554285027] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:673; }","duration":"160.199288ms","start":"2026-05-13T01:04:25.591310Z","end":"2026-05-13T01:04:25.751509Z","steps":["trace[1554285027] 'read index received' (duration: 160.186457ms)","trace[1554285027] 'applied index is now lower than readState.Index' (duration: 10.801µs)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:25.757219Z","caller":"traceutil/trace.go:172","msg":"trace[1873464922] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"173.051606ms","start":"2026-05-13T01:04:25.584113Z","end":"2026-05-13T01:04:25.757164Z","steps":["trace[1873464922] 'process raft request' (duration: 168.30073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:26.252875Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963602,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-13T01:04:26.299448Z","caller":"traceutil/trace.go:172","msg":"trace[277777662] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:674; }","duration":"547.180923ms","start":"2026-05-13T01:04:25.752236Z","end":"2026-05-13T01:04:26.299416Z","steps":["trace[277777662] 'read index received' (duration: 547.171203ms)","trace[277777662] 'applied index is now lower than readState.Index' (duration: 7.81µs)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:26.299668Z","caller":"traceutil/trace.go:172","msg":"trace[484244001] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"698.189837ms","start":"2026-05-13T01:04:25.601454Z","end":"2026-05-13T01:04:26.299643Z","steps":["trace[484244001] 'process raft request' (duration: 698.043543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:26.299719Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"706.26268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-13T01:04:26.299753Z","caller":"traceutil/trace.go:172","msg":"trace[1727774736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"706.317422ms","start":"2026-05-13T01:04:25.593426Z","end":"2026-05-13T01:04:26.299744Z","steps":["trace[1727774736] 'agreement among raft nodes before linearized reading' (duration: 706.134447ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:26.299788Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:25.593416Z","time spent":"706.363593ms","remote":"127.0.0.1:38510","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-13T01:04:26.299824Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:25.601426Z","time spent":"698.32156ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:26.315999Z","caller":"traceutil/trace.go:172","msg":"trace[410071217] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"559.151674ms","start":"2026-05-13T01:04:25.756837Z","end":"2026-05-13T01:04:26.315989Z","steps":["trace[410071217] 'process raft request' (duration: 558.914268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:26.316098Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:25.756799Z","time spent":"559.238576ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:26.315961Z","caller":"traceutil/trace.go:172","msg":"trace[239628343] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"507.334718ms","start":"2026-05-13T01:04:25.808609Z","end":"2026-05-13T01:04:26.315944Z","steps":["trace[239628343] 'process raft request' (duration: 507.268336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:26.316332Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:25.808588Z","time spent":"507.670636ms","remote":"127.0.0.1:38752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-13T01:04:26.935129Z","caller":"traceutil/trace.go:172","msg":"trace[704840606] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"196.595663ms","start":"2026-05-13T01:04:26.738515Z","end":"2026-05-13T01:04:26.935111Z","steps":["trace[704840606] 'process raft request' (duration: 196.196282ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:27.131586Z","caller":"traceutil/trace.go:172","msg":"trace[526287451] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"131.775885ms","start":"2026-05-13T01:04:26.999791Z","end":"2026-05-13T01:04:27.131567Z","steps":["trace[526287451] 'process raft request' (duration: 131.612971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:27.436628Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"177.875815ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-13T01:04:27.436995Z","caller":"traceutil/trace.go:172","msg":"trace[424834274] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"273.373731ms","start":"2026-05-13T01:04:27.163572Z","end":"2026-05-13T01:04:27.436946Z","steps":["trace[424834274] 'process raft request' (duration: 95.110677ms)","trace[424834274] 'compare' (duration: 177.668159ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:27.775342Z","caller":"traceutil/trace.go:172","msg":"trace[1051358567] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"220.821065ms","start":"2026-05-13T01:04:27.554489Z","end":"2026-05-13T01:04:27.775310Z","steps":["trace[1051358567] 'process raft request' (duration: 220.26913ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:28.063004Z","caller":"traceutil/trace.go:172","msg":"trace[559188165] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"123.186086ms","start":"2026-05-13T01:04:27.939788Z","end":"2026-05-13T01:04:28.062974Z","steps":["trace[559188165] 'process raft request' (duration: 104.411466ms)","trace[559188165] 'compare' (duration: 18.607446ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:28.844429Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963635,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:29.344686Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963635,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:29.845158Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963635,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:30.251789Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.926473107s","expected-duration":"1s"} {"level":"info","ts":"2026-05-13T01:04:30.252065Z","caller":"traceutil/trace.go:172","msg":"trace[443407888] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:693; }","duration":"1.907661025s","start":"2026-05-13T01:04:28.344376Z","end":"2026-05-13T01:04:30.252037Z","steps":["trace[443407888] 'read index received' (duration: 1.907649015s)","trace[443407888] 'applied index is now lower than readState.Index' (duration: 10.71µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:30.252576Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.908167708s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-13T01:04:30.252576Z","caller":"traceutil/trace.go:172","msg":"trace[155887638] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"1.927328308s","start":"2026-05-13T01:04:28.325200Z","end":"2026-05-13T01:04:30.252528Z","steps":["trace[155887638] 'process raft request' (duration: 1.927038671s)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:30.252679Z","caller":"traceutil/trace.go:172","msg":"trace[1878568983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:665; }","duration":"1.908287321s","start":"2026-05-13T01:04:28.344371Z","end":"2026-05-13T01:04:30.252658Z","steps":["trace[1878568983] 'agreement among raft nodes before linearized reading' (duration: 1.907768969s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:30.252713Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:28.344355Z","time spent":"1.908350043s","remote":"127.0.0.1:38510","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-13T01:04:30.252859Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:28.325178Z","time spent":"1.927526713s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:30.438738Z","caller":"traceutil/trace.go:172","msg":"trace[2026117516] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:694; }","duration":"186.567483ms","start":"2026-05-13T01:04:30.252133Z","end":"2026-05-13T01:04:30.438700Z","steps":["trace[2026117516] 'read index received' (duration: 186.554612ms)","trace[2026117516] 'applied index is now lower than readState.Index' (duration: 11.23µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:30.671009Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.247237117s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T01:04:30.671143Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.879429004s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6ts49\" limit:1 ","response":"range_response_count:1 size:18345"} {"level":"info","ts":"2026-05-13T01:04:30.671215Z","caller":"traceutil/trace.go:172","msg":"trace[30229803] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6ts49; range_end:; response_count:1; response_revision:666; }","duration":"1.879503187s","start":"2026-05-13T01:04:28.791692Z","end":"2026-05-13T01:04:30.671196Z","steps":["trace[30229803] 'agreement among raft nodes before linearized reading' (duration: 1.647063146s)","trace[30229803] 'range keys from in-memory index tree' (duration: 232.220646ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:30.671260Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:28.791647Z","time spent":"1.879602209s","remote":"127.0.0.1:38370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18367,"request content":"key:\"/registry/pods/kube-system/cilium-6ts49\" limit:1 "} {"level":"warn","ts":"2026-05-13T01:04:30.671123Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.384443895s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:04:30.671346Z","caller":"traceutil/trace.go:172","msg":"trace[2079850208] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:666; }","duration":"2.247436442s","start":"2026-05-13T01:04:28.423739Z","end":"2026-05-13T01:04:30.671175Z","steps":["trace[2079850208] 'agreement among raft nodes before linearized reading' (duration: 2.015093144s)","trace[2079850208] 'range keys from in-memory index tree' (duration: 232.121153ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:30.671383Z","caller":"traceutil/trace.go:172","msg":"trace[909435550] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:666; }","duration":"1.38464719s","start":"2026-05-13T01:04:29.286664Z","end":"2026-05-13T01:04:30.671311Z","steps":["trace[909435550] 'agreement among raft nodes before linearized reading' (duration: 1.152069835s)","trace[909435550] 'range keys from in-memory index tree' (duration: 232.342498ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:30.671861Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:29.286644Z","time spent":"1.38503579s","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T01:04:30.672794Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"233.944548ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-13T01:04:30.673053Z","caller":"traceutil/trace.go:172","msg":"trace[48488017] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"1.229812372s","start":"2026-05-13T01:04:29.443203Z","end":"2026-05-13T01:04:30.673016Z","steps":["trace[48488017] 'process raft request' (duration: 995.559856ms)","trace[48488017] 'compare' (duration: 232.094563ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:30.673151Z","caller":"traceutil/trace.go:172","msg":"trace[626130342] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"1.22613503s","start":"2026-05-13T01:04:29.447000Z","end":"2026-05-13T01:04:30.673135Z","steps":["trace[626130342] 'process raft request' (duration: 1.225884673s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:30.673259Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:29.446982Z","time spent":"1.226214071s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:04:30.673288Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:29.443171Z","time spent":"1.229960957s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:30.673412Z","caller":"traceutil/trace.go:172","msg":"trace[1491401654] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"415.522426ms","start":"2026-05-13T01:04:30.257778Z","end":"2026-05-13T01:04:30.673301Z","steps":["trace[1491401654] 'process raft request' (duration: 415.31087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:30.673852Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:30.257758Z","time spent":"415.871155ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:04:31.712916Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.016553784s","expected-duration":"1s"} {"level":"info","ts":"2026-05-13T01:04:31.713210Z","caller":"traceutil/trace.go:172","msg":"trace[1593995735] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:697; }","duration":"289.584589ms","start":"2026-05-13T01:04:31.423543Z","end":"2026-05-13T01:04:31.713128Z","steps":["trace[1593995735] 'read index received' (duration: 289.569398ms)","trace[1593995735] 'applied index is now lower than readState.Index' (duration: 13.21µs)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:31.713298Z","caller":"traceutil/trace.go:172","msg":"trace[1027144246] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"1.017039006s","start":"2026-05-13T01:04:30.696238Z","end":"2026-05-13T01:04:31.713277Z","steps":["trace[1027144246] 'process raft request' (duration: 1.016895453s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:31.713335Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"289.766553ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T01:04:31.713405Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:30.696218Z","time spent":"1.017119909s","remote":"127.0.0.1:38370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18502,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:31.713419Z","caller":"traceutil/trace.go:172","msg":"trace[228676269] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:670; }","duration":"289.868975ms","start":"2026-05-13T01:04:31.423534Z","end":"2026-05-13T01:04:31.713403Z","steps":["trace[228676269] 'agreement among raft nodes before linearized reading' (duration: 289.717232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:33.630268Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963651,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:34.130730Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963651,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:34.631423Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963651,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:35.132157Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750963651,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:35.424934Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.747457701s","expected-duration":"1s"} {"level":"info","ts":"2026-05-13T01:04:35.425211Z","caller":"traceutil/trace.go:172","msg":"trace[1716126674] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:699; }","duration":"2.295877763s","start":"2026-05-13T01:04:33.129307Z","end":"2026-05-13T01:04:35.425184Z","steps":["trace[1716126674] 'read index received' (duration: 2.295865892s)","trace[1716126674] 'applied index is now lower than readState.Index' (duration: 9.991µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:35.607226Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.183758842s","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-13T01:04:35.607344Z","caller":"traceutil/trace.go:172","msg":"trace[75121658] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:671; }","duration":"3.183914676s","start":"2026-05-13T01:04:32.423406Z","end":"2026-05-13T01:04:35.607321Z","steps":["trace[75121658] 'range keys from in-memory index tree' (duration: 3.183710482s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:35.607489Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.182544262s","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-13T01:04:35.607560Z","caller":"traceutil/trace.go:172","msg":"trace[207530377] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:671; }","duration":"3.182626464s","start":"2026-05-13T01:04:32.424917Z","end":"2026-05-13T01:04:35.607544Z","steps":["trace[207530377] 'range keys from in-memory index tree' (duration: 3.182491731s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:35.607797Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.930869826s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-13T01:04:35.607864Z","caller":"traceutil/trace.go:172","msg":"trace[869841985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:671; }","duration":"2.930949388s","start":"2026-05-13T01:04:32.676899Z","end":"2026-05-13T01:04:35.607848Z","steps":["trace[869841985] 'range keys from in-memory index tree' (duration: 2.930712853s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:35.607907Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:32.676877Z","time spent":"2.931021291s","remote":"127.0.0.1:38510","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-13T01:04:35.607982Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.478666464s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-13T01:04:35.608056Z","caller":"traceutil/trace.go:172","msg":"trace[733002119] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:671; }","duration":"2.478743756s","start":"2026-05-13T01:04:33.129292Z","end":"2026-05-13T01:04:35.608036Z","steps":["trace[733002119] 'agreement among raft nodes before linearized reading' (duration: 2.295967126s)","trace[733002119] 'range keys from in-memory index tree' (duration: 182.595426ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:35.608095Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:33.129266Z","time spent":"2.478820387s","remote":"127.0.0.1:38092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.72\" limit:1 "} {"level":"warn","ts":"2026-05-13T01:04:35.609121Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"183.779494ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-13T01:04:35.609726Z","caller":"traceutil/trace.go:172","msg":"trace[26286088] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"2.932284101s","start":"2026-05-13T01:04:32.677419Z","end":"2026-05-13T01:04:35.609703Z","steps":["trace[26286088] 'process raft request' (duration: 2.74783421s)","trace[26286088] 'compare' (duration: 182.635867ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:35.609896Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:32.677411Z","time spent":"2.932433134s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:35.638042Z","caller":"traceutil/trace.go:172","msg":"trace[696158880] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:700; }","duration":"212.747624ms","start":"2026-05-13T01:04:35.425272Z","end":"2026-05-13T01:04:35.638020Z","steps":["trace[696158880] 'read index received' (duration: 212.737373ms)","trace[696158880] 'applied index is now lower than readState.Index' (duration: 8.811µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:35.638147Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.351092291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:04:35.638200Z","caller":"traceutil/trace.go:172","msg":"trace[1423347859] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:672; }","duration":"1.351146943s","start":"2026-05-13T01:04:34.287040Z","end":"2026-05-13T01:04:35.638187Z","steps":["trace[1423347859] 'agreement among raft nodes before linearized reading' (duration: 1.35105553s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:35.638235Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:34.287011Z","time spent":"1.351217045s","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T01:04:35.638222Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.284003149s","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-13T01:04:35.638293Z","caller":"traceutil/trace.go:172","msg":"trace[353751850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:672; }","duration":"1.284083251s","start":"2026-05-13T01:04:34.354193Z","end":"2026-05-13T01:04:35.638277Z","steps":["trace[353751850] 'agreement among raft nodes before linearized reading' (duration: 1.283881286s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:35.638337Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:34.354171Z","time spent":"1.284158422s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-05-13T01:04:35.638329Z","caller":"traceutil/trace.go:172","msg":"trace[1460495095] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"2.960541222s","start":"2026-05-13T01:04:32.677769Z","end":"2026-05-13T01:04:35.638310Z","steps":["trace[1460495095] 'process raft request' (duration: 2.960284346s)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:35.638484Z","caller":"traceutil/trace.go:172","msg":"trace[1119763570] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"263.478511ms","start":"2026-05-13T01:04:35.374989Z","end":"2026-05-13T01:04:35.638468Z","steps":["trace[1119763570] 'process raft request' (duration: 263.277336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:35.638960Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:32.677764Z","time spent":"2.961106876s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:35.956626Z","caller":"traceutil/trace.go:172","msg":"trace[2101022595] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"126.467112ms","start":"2026-05-13T01:04:35.830146Z","end":"2026-05-13T01:04:35.956613Z","steps":["trace[2101022595] 'process raft request' (duration: 126.232455ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:37.426597Z","caller":"traceutil/trace.go:172","msg":"trace[1292138891] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:714; }","duration":"142.016273ms","start":"2026-05-13T01:04:37.284554Z","end":"2026-05-13T01:04:37.426570Z","steps":["trace[1292138891] 'read index received' (duration: 142.008323ms)","trace[1292138891] 'applied index is now lower than readState.Index' (duration: 6.55µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:37.426774Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"142.211317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:04:37.426782Z","caller":"traceutil/trace.go:172","msg":"trace[1044574501] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"283.663249ms","start":"2026-05-13T01:04:37.143108Z","end":"2026-05-13T01:04:37.426771Z","steps":["trace[1044574501] 'process raft request' (duration: 283.505785ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:37.426821Z","caller":"traceutil/trace.go:172","msg":"trace[267468639] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:685; }","duration":"142.272999ms","start":"2026-05-13T01:04:37.284535Z","end":"2026-05-13T01:04:37.426808Z","steps":["trace[267468639] 'agreement among raft nodes before linearized reading' (duration: 142.173186ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:04:37.967978Z","caller":"traceutil/trace.go:172","msg":"trace[1532787572] linearizableReadLoop","detail":"{readStateIndex:715; appliedIndex:715; }","duration":"270.252917ms","start":"2026-05-13T01:04:37.697697Z","end":"2026-05-13T01:04:37.967950Z","steps":["trace[1532787572] 'read index received' (duration: 270.242807ms)","trace[1532787572] 'applied index is now lower than readState.Index' (duration: 8.27µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:38.105655Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"407.932396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-13T01:04:38.105762Z","caller":"traceutil/trace.go:172","msg":"trace[277614686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:686; }","duration":"408.052208ms","start":"2026-05-13T01:04:37.697681Z","end":"2026-05-13T01:04:38.105733Z","steps":["trace[277614686] 'agreement among raft nodes before linearized reading' (duration: 270.40554ms)","trace[277614686] 'range keys from in-memory index tree' (duration: 137.382642ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:38.105815Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:37.697655Z","time spent":"408.146271ms","remote":"127.0.0.1:38510","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-13T01:04:38.106294Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"138.15301ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-13T01:04:38.106414Z","caller":"traceutil/trace.go:172","msg":"trace[247727043] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"492.11705ms","start":"2026-05-13T01:04:37.614278Z","end":"2026-05-13T01:04:38.106395Z","steps":["trace[247727043] 'process raft request' (duration: 353.781617ms)","trace[247727043] 'compare' (duration: 137.625607ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:38.106522Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:37.614252Z","time spent":"492.243003ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:38.139382Z","caller":"traceutil/trace.go:172","msg":"trace[986854150] linearizableReadLoop","detail":"{readStateIndex:716; appliedIndex:716; }","duration":"171.191073ms","start":"2026-05-13T01:04:37.968169Z","end":"2026-05-13T01:04:38.139361Z","steps":["trace[986854150] 'read index received' (duration: 171.182273ms)","trace[986854150] 'applied index is now lower than readState.Index' (duration: 7.53µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:38.139579Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"441.191965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-13T01:04:38.139618Z","caller":"traceutil/trace.go:172","msg":"trace[476904956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:687; }","duration":"441.243726ms","start":"2026-05-13T01:04:37.698362Z","end":"2026-05-13T01:04:38.139605Z","steps":["trace[476904956] 'agreement among raft nodes before linearized reading' (duration: 441.084082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:38.139651Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:37.698341Z","time spent":"441.300827ms","remote":"127.0.0.1:38510","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-13T01:04:38.139813Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"312.380958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6ts49\" limit:1 ","response":"range_response_count:1 size:18881"} {"level":"info","ts":"2026-05-13T01:04:38.140429Z","caller":"traceutil/trace.go:172","msg":"trace[272262338] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6ts49; range_end:; response_count:1; response_revision:687; }","duration":"313.004442ms","start":"2026-05-13T01:04:37.827408Z","end":"2026-05-13T01:04:38.140412Z","steps":["trace[272262338] 'agreement among raft nodes before linearized reading' (duration: 312.160983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:38.140549Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:37.827375Z","time spent":"313.150346ms","remote":"127.0.0.1:38370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18903,"request content":"key:\"/registry/pods/kube-system/cilium-6ts49\" limit:1 "} {"level":"info","ts":"2026-05-13T01:04:38.139857Z","caller":"traceutil/trace.go:172","msg":"trace[452007709] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"494.853806ms","start":"2026-05-13T01:04:37.644977Z","end":"2026-05-13T01:04:38.139831Z","steps":["trace[452007709] 'process raft request' (duration: 494.455277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:38.140779Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:37.644949Z","time spent":"495.705736ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:04:41.138022Z","caller":"traceutil/trace.go:172","msg":"trace[55768951] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"266.435758ms","start":"2026-05-13T01:04:40.871570Z","end":"2026-05-13T01:04:41.138006Z","steps":["trace[55768951] 'process raft request' (duration: 266.323095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:45.756228Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60492","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-13T01:04:46.783919Z","caller":"traceutil/trace.go:172","msg":"trace[7572111] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"100.093743ms","start":"2026-05-13T01:04:46.683801Z","end":"2026-05-13T01:04:46.783895Z","steps":["trace[7572111] 'process raft request' (duration: 99.783645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:47.495580Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"103.496464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-13T01:04:47.495755Z","caller":"traceutil/trace.go:172","msg":"trace[1345471775] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"208.848088ms","start":"2026-05-13T01:04:47.286877Z","end":"2026-05-13T01:04:47.495725Z","steps":["trace[1345471775] 'process raft request' (duration: 105.116969ms)","trace[1345471775] 'compare' (duration: 103.242058ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:47.700091Z","caller":"traceutil/trace.go:172","msg":"trace[1527238583] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"128.302391ms","start":"2026-05-13T01:04:47.571762Z","end":"2026-05-13T01:04:47.700064Z","steps":["trace[1527238583] 'process raft request' (duration: 112.420494ms)","trace[1527238583] 'compare' (duration: 15.664371ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:48.232789Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60508","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:48.247039Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60530","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:48.346741Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60544","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:48.375888Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60556","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:48.534311Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60590","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:48.677308Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60604","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:50.972364Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60630","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.035628Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60632","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.183588Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60646","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.239519Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60662","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.255779Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60678","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.267959Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60698","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.287302Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60720","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.329776Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60728","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.359871Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60740","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.440359Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60750","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.461142Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60754","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.476782Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60764","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.487882Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60784","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-13T01:04:51.502838Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60792","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-13T01:04:54.620582Z","caller":"traceutil/trace.go:172","msg":"trace[1517928442] linearizableReadLoop","detail":"{readStateIndex:877; appliedIndex:877; }","duration":"397.318245ms","start":"2026-05-13T01:04:54.223233Z","end":"2026-05-13T01:04:54.620551Z","steps":["trace[1517928442] 'read index received' (duration: 397.304814ms)","trace[1517928442] 'applied index is now lower than readState.Index' (duration: 10.711µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:04:54.620763Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"397.520139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:04:54.620800Z","caller":"traceutil/trace.go:172","msg":"trace[336792424] range","detail":"{range_begin:/registry/resourcequotas; range_end:; response_count:0; response_revision:842; }","duration":"397.57416ms","start":"2026-05-13T01:04:54.223216Z","end":"2026-05-13T01:04:54.620790Z","steps":["trace[336792424] 'agreement among raft nodes before linearized reading' (duration: 397.482139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:54.620836Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:54.223189Z","time spent":"397.638781ms","remote":"127.0.0.1:38168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas\" limit:1 "} {"level":"info","ts":"2026-05-13T01:04:54.621413Z","caller":"traceutil/trace.go:172","msg":"trace[381905363] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"406.856954ms","start":"2026-05-13T01:04:54.214539Z","end":"2026-05-13T01:04:54.621396Z","steps":["trace[381905363] 'process raft request' (duration: 406.586629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:54.621533Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:54.214496Z","time spent":"406.966017ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:04:54.693644Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"456.297538ms","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-13T01:04:54.693706Z","caller":"traceutil/trace.go:172","msg":"trace[1269158733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:843; }","duration":"456.3649ms","start":"2026-05-13T01:04:54.237327Z","end":"2026-05-13T01:04:54.693691Z","steps":["trace[1269158733] 'agreement among raft nodes before linearized reading' (duration: 456.179646ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:54.693695Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"403.976907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-05-13T01:04:54.693745Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:54.237315Z","time spent":"456.420571ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-05-13T01:04:54.693762Z","caller":"traceutil/trace.go:172","msg":"trace[10261968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:843; }","duration":"404.043199ms","start":"2026-05-13T01:04:54.289698Z","end":"2026-05-13T01:04:54.693742Z","steps":["trace[10261968] 'agreement among raft nodes before linearized reading' (duration: 403.858755ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:54.693875Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"270.513541ms","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-13T01:04:54.693931Z","caller":"traceutil/trace.go:172","msg":"trace[293524488] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:843; }","duration":"270.565392ms","start":"2026-05-13T01:04:54.423352Z","end":"2026-05-13T01:04:54.693918Z","steps":["trace[293524488] 'agreement among raft nodes before linearized reading' (duration: 270.492461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:54.693995Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"407.16689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:04:54.694025Z","caller":"traceutil/trace.go:172","msg":"trace[245232195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:843; }","duration":"407.195751ms","start":"2026-05-13T01:04:54.286820Z","end":"2026-05-13T01:04:54.694015Z","steps":["trace[245232195] 'agreement among raft nodes before linearized reading' (duration: 406.997617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:54.694048Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:54.286804Z","time spent":"407.238392ms","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-13T01:04:54.694004Z","caller":"traceutil/trace.go:172","msg":"trace[1003290437] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"464.849608ms","start":"2026-05-13T01:04:54.229113Z","end":"2026-05-13T01:04:54.693963Z","steps":["trace[1003290437] 'process raft request' (duration: 464.511511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:54.694279Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:54.229100Z","time spent":"465.053113ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:04:54.693799Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:54.289685Z","time spent":"404.10269ms","remote":"127.0.0.1:38510","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-13T01:04:56.910196Z","caller":"traceutil/trace.go:172","msg":"trace[1690742241] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"137.314084ms","start":"2026-05-13T01:04:56.772856Z","end":"2026-05-13T01:04:56.910170Z","steps":["trace[1690742241] 'process raft request' (duration: 112.625022ms)","trace[1690742241] 'compare' (duration: 24.57561ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:04:57.202915Z","caller":"traceutil/trace.go:172","msg":"trace[1485466886] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"224.336181ms","start":"2026-05-13T01:04:56.978554Z","end":"2026-05-13T01:04:57.202890Z","steps":["trace[1485466886] 'process raft request' (duration: 224.143857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:04:59.204296Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750964111,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:04:59.704440Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750964111,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:05:00.205211Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219790750964111,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-13T01:05:00.416890Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.771662796s","expected-duration":"1s"} {"level":"info","ts":"2026-05-13T01:05:00.417184Z","caller":"traceutil/trace.go:172","msg":"trace[1460353800] linearizableReadLoop","detail":"{readStateIndex:899; appliedIndex:899; }","duration":"1.713413557s","start":"2026-05-13T01:04:58.703701Z","end":"2026-05-13T01:05:00.417115Z","steps":["trace[1460353800] 'read index received' (duration: 1.713398277s)","trace[1460353800] 'applied index is now lower than readState.Index' (duration: 13.19µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:05:00.417463Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.713721343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:05:00.417500Z","caller":"traceutil/trace.go:172","msg":"trace[795368355] range","detail":"{range_begin:/registry/flowschemas; range_end:; response_count:0; response_revision:863; }","duration":"1.713802434s","start":"2026-05-13T01:04:58.703689Z","end":"2026-05-13T01:05:00.417492Z","steps":["trace[795368355] 'agreement among raft nodes before linearized reading' (duration: 1.713652712s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.417533Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:58.703661Z","time spent":"1.713864646s","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":27,"request content":"key:\"/registry/flowschemas\" limit:1 "} {"level":"info","ts":"2026-05-13T01:05:00.417539Z","caller":"traceutil/trace.go:172","msg":"trace[352312015] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"1.772371799s","start":"2026-05-13T01:04:58.645120Z","end":"2026-05-13T01:05:00.417492Z","steps":["trace[352312015] 'process raft request' (duration: 1.772159505s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.417702Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:58.645091Z","time spent":"1.772544603s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:05:00.494568Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.071108164s","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-13T01:05:00.494631Z","caller":"traceutil/trace.go:172","msg":"trace[66061889] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:864; }","duration":"1.071189785s","start":"2026-05-13T01:04:59.423427Z","end":"2026-05-13T01:05:00.494617Z","steps":["trace[66061889] 'agreement among raft nodes before linearized reading' (duration: 1.071074343s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.494646Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.682222454s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-13T01:05:00.494723Z","caller":"traceutil/trace.go:172","msg":"trace[1878507124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:864; }","duration":"1.682310666s","start":"2026-05-13T01:04:58.812394Z","end":"2026-05-13T01:05:00.494705Z","steps":["trace[1878507124] 'agreement among raft nodes before linearized reading' (duration: 1.682094362s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.494763Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:58.812357Z","time spent":"1.682397807s","remote":"127.0.0.1:38510","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-13T01:05:00.494766Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.245517475s","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:492"} {"level":"warn","ts":"2026-05-13T01:05:00.494839Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"688.568466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:05:00.494849Z","caller":"traceutil/trace.go:172","msg":"trace[540659917] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:864; }","duration":"1.245612587s","start":"2026-05-13T01:04:59.249216Z","end":"2026-05-13T01:05:00.494829Z","steps":["trace[540659917] 'agreement among raft nodes before linearized reading' (duration: 1.245362122s)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:05:00.494863Z","caller":"traceutil/trace.go:172","msg":"trace[1721377516] range","detail":"{range_begin:/registry/priorityclasses; range_end:; response_count:0; response_revision:864; }","duration":"688.594477ms","start":"2026-05-13T01:04:59.806262Z","end":"2026-05-13T01:05:00.494856Z","steps":["trace[1721377516] 'agreement among raft nodes before linearized reading' (duration: 688.548536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.494897Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:59.806243Z","time spent":"688.647447ms","remote":"127.0.0.1:38768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses\" limit:1 "} {"level":"warn","ts":"2026-05-13T01:05:00.494899Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:59.249190Z","time spent":"1.245699088s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-05-13T01:05:00.495039Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.208698903s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:05:00.495069Z","caller":"traceutil/trace.go:172","msg":"trace[568701301] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:864; }","duration":"1.208726733s","start":"2026-05-13T01:04:59.286334Z","end":"2026-05-13T01:05:00.495061Z","steps":["trace[568701301] 'agreement among raft nodes before linearized reading' (duration: 1.208682323s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.495078Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"738.030638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:05:00.495120Z","caller":"traceutil/trace.go:172","msg":"trace[1456345512] range","detail":"{range_begin:/registry/rolebindings; range_end:; response_count:0; response_revision:864; }","duration":"738.052628ms","start":"2026-05-13T01:04:59.757040Z","end":"2026-05-13T01:05:00.495093Z","steps":["trace[1456345512] 'agreement among raft nodes before linearized reading' (duration: 738.013197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.495140Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:59.757016Z","time spent":"738.119ms","remote":"127.0.0.1:38706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":27,"request content":"key:\"/registry/rolebindings\" limit:1 "} {"level":"warn","ts":"2026-05-13T01:05:00.495090Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:59.286308Z","time spent":"1.208777754s","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-13T01:05:00.495259Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"868.065835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:05:00.495287Z","caller":"traceutil/trace.go:172","msg":"trace[1817946334] range","detail":"{range_begin:/registry/controllers; range_end:; response_count:0; response_revision:864; }","duration":"868.096236ms","start":"2026-05-13T01:04:59.627185Z","end":"2026-05-13T01:05:00.495281Z","steps":["trace[1817946334] 'agreement among raft nodes before linearized reading' (duration: 868.048475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.495308Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:59.627162Z","time spent":"868.136587ms","remote":"127.0.0.1:38418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":27,"request content":"key:\"/registry/controllers\" limit:1 "} {"level":"warn","ts":"2026-05-13T01:05:00.495425Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"962.32596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipaddresses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:05:00.495449Z","caller":"traceutil/trace.go:172","msg":"trace[2036557614] range","detail":"{range_begin:/registry/ipaddresses; range_end:; response_count:0; response_revision:864; }","duration":"962.350991ms","start":"2026-05-13T01:04:59.533093Z","end":"2026-05-13T01:05:00.495444Z","steps":["trace[2036557614] 'agreement among raft nodes before linearized reading' (duration: 962.30946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.495467Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:59.533066Z","time spent":"962.396502ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":27,"request content":"key:\"/registry/ipaddresses\" limit:1 "} {"level":"warn","ts":"2026-05-13T01:05:00.495755Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.581508487s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-13T01:05:00.495819Z","caller":"traceutil/trace.go:172","msg":"trace[1607128756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:864; }","duration":"1.581576168s","start":"2026-05-13T01:04:58.914232Z","end":"2026-05-13T01:05:00.495808Z","steps":["trace[1607128756] 'agreement among raft nodes before linearized reading' (duration: 1.580851415s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.496010Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.587489163s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deviceclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T01:05:00.496025Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:58.914221Z","time spent":"1.581788103s","remote":"127.0.0.1:38510","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-13T01:05:00.496087Z","caller":"traceutil/trace.go:172","msg":"trace[55773036] range","detail":"{range_begin:/registry/deviceclasses; range_end:; response_count:0; response_revision:864; }","duration":"1.587580424s","start":"2026-05-13T01:04:58.908490Z","end":"2026-05-13T01:05:00.496070Z","steps":["trace[55773036] 'agreement among raft nodes before linearized reading' (duration: 1.587431971s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.496129Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:58.908462Z","time spent":"1.587658525s","remote":"127.0.0.1:39070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":27,"response count":0,"response size":27,"request content":"key:\"/registry/deviceclasses\" limit:1 "} {"level":"info","ts":"2026-05-13T01:05:00.496499Z","caller":"traceutil/trace.go:172","msg":"trace[1216268408] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"1.53948563s","start":"2026-05-13T01:04:58.956988Z","end":"2026-05-13T01:05:00.496473Z","steps":["trace[1216268408] 'process raft request' (duration: 1.539402328s)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:05:00.496641Z","caller":"traceutil/trace.go:172","msg":"trace[681769248] transaction","detail":"{read_only:false; response_revision:865; number_of_response:1; }","duration":"1.722702351s","start":"2026-05-13T01:04:58.773929Z","end":"2026-05-13T01:05:00.496632Z","steps":["trace[681769248] 'process raft request' (duration: 1.722259161s)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:00.496683Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:58.956966Z","time spent":"1.539621114s","remote":"127.0.0.1:38436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2879,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:05:00.496726Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:04:58.773854Z","time spent":"1.722818502s","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-13T01:05:10.409974Z","caller":"traceutil/trace.go:172","msg":"trace[96857746] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"120.491176ms","start":"2026-05-13T01:05:10.289431Z","end":"2026-05-13T01:05:10.409922Z","steps":["trace[96857746] 'process raft request' (duration: 120.288753ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:05:11.047679Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"286.829065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceclaimtemplates\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:05:11.047782Z","caller":"traceutil/trace.go:172","msg":"trace[779321919] range","detail":"{range_begin:/registry/resourceclaimtemplates; range_end:; response_count:0; response_revision:947; }","duration":"286.939386ms","start":"2026-05-13T01:05:10.760814Z","end":"2026-05-13T01:05:11.047754Z","steps":["trace[779321919] 'range keys from in-memory index tree' (duration: 286.675661ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:05:12.991561Z","caller":"traceutil/trace.go:172","msg":"trace[1484660779] linearizableReadLoop","detail":"{readStateIndex:988; appliedIndex:988; }","duration":"272.535548ms","start":"2026-05-13T01:05:12.718993Z","end":"2026-05-13T01:05:12.991529Z","steps":["trace[1484660779] 'read index received' (duration: 272.522948ms)","trace[1484660779] 'applied index is now lower than readState.Index' (duration: 11.76µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:05:12.991907Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"272.889624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-13T01:05:12.991948Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"271.653414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-13T01:05:12.992051Z","caller":"traceutil/trace.go:172","msg":"trace[1806755976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:951; }","duration":"271.779366ms","start":"2026-05-13T01:05:12.720253Z","end":"2026-05-13T01:05:12.992033Z","steps":["trace[1806755976] 'agreement among raft nodes before linearized reading' (duration: 271.523241ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:05:12.991978Z","caller":"traceutil/trace.go:172","msg":"trace[903694966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:950; }","duration":"272.974066ms","start":"2026-05-13T01:05:12.718987Z","end":"2026-05-13T01:05:12.991961Z","steps":["trace[903694966] 'agreement among raft nodes before linearized reading' (duration: 272.577709ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:05:12.992342Z","caller":"traceutil/trace.go:172","msg":"trace[447174365] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"275.099722ms","start":"2026-05-13T01:05:12.717201Z","end":"2026-05-13T01:05:12.992301Z","steps":["trace[447174365] 'process raft request' (duration: 274.39421ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:05:57.379997Z","caller":"traceutil/trace.go:172","msg":"trace[736247100] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"125.424201ms","start":"2026-05-13T01:05:57.254553Z","end":"2026-05-13T01:05:57.379977Z","steps":["trace[736247100] 'process raft request' (duration: 121.072186ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:06:27.117365Z","caller":"traceutil/trace.go:172","msg":"trace[295226048] linearizableReadLoop","detail":"{readStateIndex:1254; appliedIndex:1254; }","duration":"222.842699ms","start":"2026-05-13T01:06:26.894483Z","end":"2026-05-13T01:06:27.117325Z","steps":["trace[295226048] 'read index received' (duration: 222.826778ms)","trace[295226048] 'applied index is now lower than readState.Index' (duration: 13.371µs)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:06:27.117606Z","caller":"traceutil/trace.go:172","msg":"trace[839235875] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"239.77974ms","start":"2026-05-13T01:06:26.877804Z","end":"2026-05-13T01:06:27.117584Z","steps":["trace[839235875] 'process raft request' (duration: 239.626309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:06:27.117687Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"223.193532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" limit:1 ","response":"range_response_count:1 size:4460"} {"level":"info","ts":"2026-05-13T01:06:27.117772Z","caller":"traceutil/trace.go:172","msg":"trace[1928804587] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:1201; }","duration":"223.262213ms","start":"2026-05-13T01:06:26.894468Z","end":"2026-05-13T01:06:27.117730Z","steps":["trace[1928804587] 'agreement among raft nodes before linearized reading' (duration: 223.045281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:06:27.199242Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"254.741767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-13T01:06:27.199322Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"293.354143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" limit:1 ","response":"range_response_count:1 size:452"} {"level":"info","ts":"2026-05-13T01:06:27.199349Z","caller":"traceutil/trace.go:172","msg":"trace[1161925550] range","detail":"{range_begin:/registry/services/endpoints; range_end:; response_count:0; response_revision:1202; }","duration":"254.854428ms","start":"2026-05-13T01:06:26.944460Z","end":"2026-05-13T01:06:27.199315Z","steps":["trace[1161925550] 'agreement among raft nodes before linearized reading' (duration: 234.150534ms)","trace[1161925550] 'range keys from in-memory index tree' (duration: 20.557392ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:06:27.199376Z","caller":"traceutil/trace.go:172","msg":"trace[1068793335] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-oidc-hmac; range_end:; response_count:1; response_revision:1202; }","duration":"293.411543ms","start":"2026-05-13T01:06:26.905950Z","end":"2026-05-13T01:06:27.199362Z","steps":["trace[1068793335] 'agreement among raft nodes before linearized reading' (duration: 272.677119ms)","trace[1068793335] 'range keys from in-memory index tree' (duration: 20.584172ms)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:06:27.199356Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"257.805731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:06:27.199479Z","caller":"traceutil/trace.go:172","msg":"trace[432950000] range","detail":"{range_begin:/registry/persistentvolumeclaims; range_end:; response_count:0; response_revision:1202; }","duration":"257.956042ms","start":"2026-05-13T01:06:26.941492Z","end":"2026-05-13T01:06:27.199448Z","steps":["trace[432950000] 'agreement among raft nodes before linearized reading' (duration: 237.099707ms)","trace[432950000] 'range keys from in-memory index tree' (duration: 20.649163ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:06:27.199699Z","caller":"traceutil/trace.go:172","msg":"trace[1440118048] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"253.284889ms","start":"2026-05-13T01:06:26.946404Z","end":"2026-05-13T01:06:27.199689Z","steps":["trace[1440118048] 'process raft request' (duration: 232.211721ms)","trace[1440118048] 'compare' (duration: 20.842105ms)"],"step_count":2} {"level":"info","ts":"2026-05-13T01:06:27.199865Z","caller":"traceutil/trace.go:172","msg":"trace[1669546373] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"156.799549ms","start":"2026-05-13T01:06:27.043058Z","end":"2026-05-13T01:06:27.199858Z","steps":["trace[1669546373] 'process raft request' (duration: 156.559176ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:06:27.915012Z","caller":"traceutil/trace.go:172","msg":"trace[1006594361] linearizableReadLoop","detail":"{readStateIndex:1258; appliedIndex:1258; }","duration":"123.863608ms","start":"2026-05-13T01:06:27.791108Z","end":"2026-05-13T01:06:27.914971Z","steps":["trace[1006594361] 'read index received' (duration: 123.848748ms)","trace[1006594361] 'applied index is now lower than readState.Index' (duration: 12.82µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:06:27.915214Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"124.08802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" limit:1 ","response":"range_response_count:1 size:1754"} {"level":"info","ts":"2026-05-13T01:06:27.915275Z","caller":"traceutil/trace.go:172","msg":"trace[1394667164] range","detail":"{range_begin:/registry/configmaps/kube-node-lease/kube-root-ca.crt; range_end:; response_count:1; response_revision:1205; }","duration":"124.158831ms","start":"2026-05-13T01:06:27.791104Z","end":"2026-05-13T01:06:27.915262Z","steps":["trace[1394667164] 'agreement among raft nodes before linearized reading' (duration: 123.956569ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:06:27.915270Z","caller":"traceutil/trace.go:172","msg":"trace[194491618] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"210.358263ms","start":"2026-05-13T01:06:27.704891Z","end":"2026-05-13T01:06:27.915249Z","steps":["trace[194491618] 'process raft request' (duration: 210.12331ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:06:28.124824Z","caller":"traceutil/trace.go:172","msg":"trace[1219812090] linearizableReadLoop","detail":"{readStateIndex:1259; appliedIndex:1259; }","duration":"209.64258ms","start":"2026-05-13T01:06:27.915157Z","end":"2026-05-13T01:06:28.124799Z","steps":["trace[1219812090] 'read index received' (duration: 209.63579ms)","trace[1219812090] 'applied index is now lower than readState.Index' (duration: 5.81µs)"],"step_count":2} {"level":"warn","ts":"2026-05-13T01:06:28.125898Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"326.046794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-13T01:06:28.125964Z","caller":"traceutil/trace.go:172","msg":"trace[162991256] range","detail":"{range_begin:/registry/persistentvolumeclaims; range_end:; response_count:0; response_revision:1206; }","duration":"326.119975ms","start":"2026-05-13T01:06:27.799828Z","end":"2026-05-13T01:06:28.125948Z","steps":["trace[162991256] 'agreement among raft nodes before linearized reading' (duration: 325.110043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:06:28.125999Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:06:27.799818Z","time spent":"326.172006ms","remote":"127.0.0.1:38310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumeclaims\" limit:1 "} {"level":"info","ts":"2026-05-13T01:06:28.126489Z","caller":"traceutil/trace.go:172","msg":"trace[1362896432] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"232.465138ms","start":"2026-05-13T01:06:27.894005Z","end":"2026-05-13T01:06:28.126470Z","steps":["trace[1362896432] 'process raft request' (duration: 232.309416ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:06:28.126528Z","caller":"traceutil/trace.go:172","msg":"trace[1380139841] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"421.301599ms","start":"2026-05-13T01:06:27.705182Z","end":"2026-05-13T01:06:28.126483Z","steps":["trace[1380139841] 'process raft request' (duration: 419.745641ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:06:28.126793Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-13T01:06:27.705153Z","time spent":"421.499812ms","remote":"127.0.0.1:38510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-13T01:06:28.126982Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"155.334067ms","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-13T01:06:28.127036Z","caller":"traceutil/trace.go:172","msg":"trace[195435018] range","detail":"{range_begin:/registry/configmaps; range_end:; response_count:0; response_revision:1208; }","duration":"155.391908ms","start":"2026-05-13T01:06:27.971632Z","end":"2026-05-13T01:06:28.127024Z","steps":["trace[195435018] 'agreement among raft nodes before linearized reading' (duration: 155.297367ms)"],"step_count":1} {"level":"warn","ts":"2026-05-13T01:06:28.127102Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"207.257683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" limit:1 ","response":"range_response_count:1 size:1754"} {"level":"warn","ts":"2026-05-13T01:06:28.127167Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"283.11796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-public/cluster-info\" limit:1 ","response":"range_response_count:1 size:2161"} {"level":"info","ts":"2026-05-13T01:06:28.127266Z","caller":"traceutil/trace.go:172","msg":"trace[1606111591] range","detail":"{range_begin:/registry/configmaps/kube-public/cluster-info; range_end:; response_count:1; response_revision:1206; }","duration":"283.234651ms","start":"2026-05-13T01:06:27.844007Z","end":"2026-05-13T01:06:28.127242Z","steps":["trace[1606111591] 'agreement among raft nodes before linearized reading' (duration: 280.891924ms)"],"step_count":1} {"level":"info","ts":"2026-05-13T01:06:28.127203Z","caller":"traceutil/trace.go:172","msg":"trace[1467604065] range","detail":"{range_begin:/registry/configmaps/kube-node-lease/kube-root-ca.crt; range_end:; response_count:1; response_revision:1208; }","duration":"207.88853ms","start":"2026-05-13T01:06:27.919299Z","end":"2026-05-13T01:06:28.127187Z","steps":["trace[1467604065] 'agreement among raft nodes before linearized reading' (duration: 207.183093ms)"],"step_count":1}