{"level":"warn","ts":"2026-06-08T15:45:37.100719Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-06-08T15:45:37.100871Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-06-08T15:45:37.100914Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.195:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.19.213.195:2380","--initial-cluster=controller=https://199.19.213.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.195: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-06-08T15:45:37.101031Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-06-08T15:45:37.101091Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T15:45:37.101148Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.195:2380"]} {"level":"info","ts":"2026-06-08T15:45:37.102404Z","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-06-08T15:45:37.102831Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.195:2379"]} {"level":"info","ts":"2026-06-08T15:45:37.102975Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.195:2380"],"listen-peer-urls":["https://199.19.213.195:2380"],"advertise-client-urls":["https://199.19.213.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.19.213.195: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-06-08T15:45:37.103571Z","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: 0xc000078968}"} {"level":"info","ts":"2026-06-08T15:45:37.107953Z","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-06-08T15:45:37.108017Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.526704ms"} {"level":"info","ts":"2026-06-08T15:45:37.108050Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-06-08T15:45:37.108084Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-06-08T15:45:37.108124Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-06-08T15:45:37.114093Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-06-08T15:45:37.114247Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"2808ca5e53a916c4","cluster-id":"b7ef986abcd4d0b8"} {"level":"info","ts":"2026-06-08T15:45:37.114299Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-06-08T15:45:37.114380Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"2808ca5e53a916c4 switched to configuration voters=()"} {"level":"info","ts":"2026-06-08T15:45:37.114442Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"2808ca5e53a916c4 became follower at term 0"} {"level":"info","ts":"2026-06-08T15:45:37.114472Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft 2808ca5e53a916c4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-08T15:45:37.114504Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"2808ca5e53a916c4 became follower at term 1"} {"level":"info","ts":"2026-06-08T15:45:37.114565Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"2808ca5e53a916c4 switched to configuration voters=(2884778067810129604)"} {"level":"warn","ts":"2026-06-08T15:45:37.120301Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-08T15:45:37.122590Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-08T15:45:37.125557Z","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-06-08T15:45:37.126160Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"2808ca5e53a916c4","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-08T15:45:37.126418Z","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-06-08T15:45:37.126703Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2808ca5e53a916c4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-08T15:45:37.126862Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.19.213.195:2380"} {"level":"info","ts":"2026-06-08T15:45:37.126927Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.19.213.195:2380"} {"level":"info","ts":"2026-06-08T15:45:37.127004Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"2808ca5e53a916c4","initial-advertise-peer-urls":["https://199.19.213.195:2380"],"listen-peer-urls":["https://199.19.213.195:2380"],"advertise-client-urls":["https://199.19.213.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-08T15:45:37.127035Z","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-06-08T15:45:37.127122Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-08T15:45:37.127954Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"2808ca5e53a916c4 switched to configuration voters=(2884778067810129604)"} {"level":"info","ts":"2026-06-08T15:45:37.128880Z","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-06-08T15:45:37.128929Z","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-06-08T15:45:37.129481Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"b7ef986abcd4d0b8","local-member-id":"2808ca5e53a916c4","added-peer-id":"2808ca5e53a916c4","added-peer-peer-urls":["https://199.19.213.195:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-06-08T15:45:38.114676Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"2808ca5e53a916c4 is starting a new election at term 1"} {"level":"info","ts":"2026-06-08T15:45:38.114805Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"2808ca5e53a916c4 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-08T15:45:38.114870Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"2808ca5e53a916c4 received MsgPreVoteResp from 2808ca5e53a916c4 at term 1"} {"level":"info","ts":"2026-06-08T15:45:38.114887Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"2808ca5e53a916c4 has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-06-08T15:45:38.115151Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"2808ca5e53a916c4 became candidate at term 2"} {"level":"info","ts":"2026-06-08T15:45:38.116994Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"2808ca5e53a916c4 received MsgVoteResp from 2808ca5e53a916c4 at term 2"} {"level":"info","ts":"2026-06-08T15:45:38.117052Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"2808ca5e53a916c4 has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-06-08T15:45:38.117116Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"2808ca5e53a916c4 became leader at term 2"} {"level":"info","ts":"2026-06-08T15:45:38.117136Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: 2808ca5e53a916c4 elected leader 2808ca5e53a916c4 at term 2"} {"level":"info","ts":"2026-06-08T15:45:38.122129Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"2808ca5e53a916c4","local-member-attributes":"{Name:controller ClientURLs:[https://199.19.213.195:2379]}","cluster-id":"b7ef986abcd4d0b8","publish-timeout":"7s"} {"level":"info","ts":"2026-06-08T15:45:38.122327Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T15:45:38.122582Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-06-08T15:45:38.123548Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-08T15:45:38.124126Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"b7ef986abcd4d0b8","local-member-id":"2808ca5e53a916c4","cluster-version":"3.6"} {"level":"info","ts":"2026-06-08T15:45:38.124355Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-06-08T15:45:38.124492Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-06-08T15:45:38.124679Z","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-06-08T15:45:38.124849Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-06-08T15:45:38.126385Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.195:2379"} {"level":"info","ts":"2026-06-08T15:45:38.126460Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"warn","ts":"2026-06-08T15:45:38.127471Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-06-08T15:45:38.127564Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-08T15:45:38.130413Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-08T15:45:38.135336Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-08T15:45:38.135411Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-06-08T15:45:38.483246Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47994","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.500042Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48016","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.511648Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48018","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.525244Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48070","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.544881Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48086","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.551812Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48112","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.558815Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48126","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.568380Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48144","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.579630Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48174","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.590902Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48178","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.600978Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48200","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.610611Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48222","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.619208Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48254","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.629274Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48256","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.639943Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48274","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.649291Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48288","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.659054Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48316","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.670790Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48324","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.678438Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48352","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.688591Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48370","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.698826Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48384","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.734623Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48404","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.743425Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48420","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.753747Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48424","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.763244Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48440","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.772059Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48458","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.782596Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48466","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.793671Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48490","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.802842Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48502","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.814292Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48522","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.821732Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48530","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.841742Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48552","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.853354Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48600","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.860961Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48624","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.870646Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48638","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.879262Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48646","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.888338Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48684","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.904035Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48714","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.912842Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48730","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.925240Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48744","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.937516Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48770","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.946758Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48798","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.958361Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48810","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.977833Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48838","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:38.981120Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48868","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.003956Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48878","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.013557Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48902","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.025091Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48914","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.035365Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48936","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.046937Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48958","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.056789Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48986","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.067648Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48990","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.079650Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49004","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.088916Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49024","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.099913Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49052","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.110288Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49068","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.116785Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49092","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.148829Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49112","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.161528Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49118","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.172263Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49142","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:39.224075Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49156","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:45:42.868347Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"305.94923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:45:42.868498Z","caller":"traceutil/trace.go:172","msg":"trace[751047429] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:0; response_revision:278; }","duration":"306.138046ms","start":"2026-06-08T15:45:42.562346Z","end":"2026-06-08T15:45:42.868484Z","steps":["trace[751047429] 'range keys from in-memory index tree' (duration: 305.802566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:45:42.868543Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:45:42.562325Z","time spent":"306.209868ms","remote":"127.0.0.1:48364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 "} {"level":"info","ts":"2026-06-08T15:45:42.968907Z","caller":"traceutil/trace.go:172","msg":"trace[971349876] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"340.788129ms","start":"2026-06-08T15:45:42.628088Z","end":"2026-06-08T15:45:42.968876Z","steps":["trace[971349876] 'process raft request' (duration: 340.536833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:45:42.969704Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:45:42.628063Z","time spent":"340.966123ms","remote":"127.0.0.1:48644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":481,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:45:43.213318Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:45:42.628373Z","time spent":"584.939733ms","remote":"127.0.0.1:48326","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/06/08 15:45:43 WARNING: [core] [Server #6]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-06-08T15:45:43.385143Z","caller":"traceutil/trace.go:172","msg":"trace[1410812493] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"412.857163ms","start":"2026-06-08T15:45:42.972268Z","end":"2026-06-08T15:45:43.385125Z","steps":["trace[1410812493] 'process raft request' (duration: 412.74486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:45:43.385236Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:45:42.972238Z","time spent":"412.961057ms","remote":"127.0.0.1:48364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:45:47.770061Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"258.024978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-08T15:45:47.770155Z","caller":"traceutil/trace.go:172","msg":"trace[319892258] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:355; }","duration":"258.12983ms","start":"2026-06-08T15:45:47.512009Z","end":"2026-06-08T15:45:47.770139Z","steps":["trace[319892258] 'range keys from in-memory index tree' (duration: 257.674368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:45:47.770260Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"157.045997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-08T15:45:47.770317Z","caller":"traceutil/trace.go:172","msg":"trace[177672698] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:355; }","duration":"157.097418ms","start":"2026-06-08T15:45:47.613201Z","end":"2026-06-08T15:45:47.770298Z","steps":["trace[177672698] 'range keys from in-memory index tree' (duration: 156.515043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:45:47.770669Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"207.211719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-06-08T15:45:47.770692Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"107.664627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-08T15:45:47.770743Z","caller":"traceutil/trace.go:172","msg":"trace[1095504864] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:355; }","duration":"107.717248ms","start":"2026-06-08T15:45:47.663013Z","end":"2026-06-08T15:45:47.770730Z","steps":["trace[1095504864] 'range keys from in-memory index tree' (duration: 106.65643ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:45:47.770742Z","caller":"traceutil/trace.go:172","msg":"trace[2040508579] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:355; }","duration":"207.544598ms","start":"2026-06-08T15:45:47.563181Z","end":"2026-06-08T15:45:47.770726Z","steps":["trace[2040508579] 'range keys from in-memory index tree' (duration: 206.541842ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:45:57.573885Z","caller":"traceutil/trace.go:172","msg":"trace[385516676] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"132.627006ms","start":"2026-06-08T15:45:57.441235Z","end":"2026-06-08T15:45:57.573862Z","steps":["trace[385516676] 'process raft request' (duration: 132.423111ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:45:57.579361Z","caller":"traceutil/trace.go:172","msg":"trace[1187746020] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"135.68929ms","start":"2026-06-08T15:45:57.443654Z","end":"2026-06-08T15:45:57.579343Z","steps":["trace[1187746020] 'process raft request' (duration: 135.410754ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:45:58.694699Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"197.148007ms","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-06-08T15:45:58.694912Z","caller":"traceutil/trace.go:172","msg":"trace[208066667] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:433; }","duration":"197.371173ms","start":"2026-06-08T15:45:58.497529Z","end":"2026-06-08T15:45:58.694900Z","steps":["trace[208066667] 'range keys from in-memory index tree' (duration: 197.086045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:02.998206Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278494746,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T15:46:03.308074Z","caller":"traceutil/trace.go:172","msg":"trace[470710494] linearizableReadLoop","detail":"{readStateIndex:459; appliedIndex:459; }","duration":"809.951687ms","start":"2026-06-08T15:46:02.498089Z","end":"2026-06-08T15:46:03.308041Z","steps":["trace[470710494] 'read index received' (duration: 809.940587ms)","trace[470710494] 'applied index is now lower than readState.Index' (duration: 9.38µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:03.308179Z","caller":"traceutil/trace.go:172","msg":"trace[1990000409] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"928.432875ms","start":"2026-06-08T15:46:02.379735Z","end":"2026-06-08T15:46:03.308168Z","steps":["trace[1990000409] 'process raft request' (duration: 928.333852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:03.308228Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"810.120241ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:03.308905Z","caller":"traceutil/trace.go:172","msg":"trace[1012458741] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:443; }","duration":"810.813667ms","start":"2026-06-08T15:46:02.498080Z","end":"2026-06-08T15:46:03.308894Z","steps":["trace[1012458741] 'agreement among raft nodes before linearized reading' (duration: 810.06291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:03.308610Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"215.27124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:03.309087Z","caller":"traceutil/trace.go:172","msg":"trace[1109118821] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:443; }","duration":"215.75893ms","start":"2026-06-08T15:46:03.093319Z","end":"2026-06-08T15:46:03.309078Z","steps":["trace[1109118821] 'agreement among raft nodes before linearized reading' (duration: 215.245649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:03.309811Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:02.379679Z","time spent":"928.997667ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:04.116854Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278494751,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T15:46:04.208402Z","caller":"traceutil/trace.go:172","msg":"trace[1158882718] linearizableReadLoop","detail":"{readStateIndex:460; appliedIndex:460; }","duration":"591.58594ms","start":"2026-06-08T15:46:03.616774Z","end":"2026-06-08T15:46:04.208360Z","steps":["trace[1158882718] 'read index received' (duration: 591.57422ms)","trace[1158882718] 'applied index is now lower than readState.Index' (duration: 10.04µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:04.226659Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"697.912507ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:46:04.226867Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"610.086272ms","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-06-08T15:46:04.226928Z","caller":"traceutil/trace.go:172","msg":"trace[259387669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:443; }","duration":"610.130933ms","start":"2026-06-08T15:46:03.616766Z","end":"2026-06-08T15:46:04.226897Z","steps":["trace[259387669] 'agreement among raft nodes before linearized reading' (duration: 591.755704ms)","trace[259387669] 'range keys from in-memory index tree' (duration: 18.233726ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:04.226965Z","caller":"traceutil/trace.go:172","msg":"trace[973258782] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"610.244506ms","start":"2026-06-08T15:46:03.616694Z","end":"2026-06-08T15:46:04.226939Z","steps":["trace[973258782] 'process raft request' (duration: 591.813416ms)","trace[973258782] 'compare' (duration: 18.190764ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:04.226989Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:03.616737Z","time spent":"610.236706ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:46:04.227092Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:03.616656Z","time spent":"610.368248ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:46:04.226864Z","caller":"traceutil/trace.go:172","msg":"trace[1265650585] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:443; }","duration":"698.124641ms","start":"2026-06-08T15:46:03.528719Z","end":"2026-06-08T15:46:04.226844Z","steps":["trace[1265650585] 'range keys from in-memory index tree' (duration: 697.838086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:04.230430Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"610.502981ms","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-06-08T15:46:04.230516Z","caller":"traceutil/trace.go:172","msg":"trace[1937869253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:444; }","duration":"610.590453ms","start":"2026-06-08T15:46:03.619913Z","end":"2026-06-08T15:46:04.230504Z","steps":["trace[1937869253] 'agreement among raft nodes before linearized reading' (duration: 610.422179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:04.230566Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:03.619877Z","time spent":"610.678106ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-06-08T15:46:04.231009Z","caller":"traceutil/trace.go:172","msg":"trace[180850078] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"287.430138ms","start":"2026-06-08T15:46:03.943553Z","end":"2026-06-08T15:46:04.230983Z","steps":["trace[180850078] 'process raft request' (duration: 287.179162ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:07.460619Z","caller":"traceutil/trace.go:172","msg":"trace[87830928] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"139.348361ms","start":"2026-06-08T15:46:07.321250Z","end":"2026-06-08T15:46:07.460598Z","steps":["trace[87830928] 'process raft request' (duration: 139.200558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:21.999096Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495041,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:46:22.484502Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.035815824s","expected-duration":"1s"} {"level":"info","ts":"2026-06-08T15:46:22.484741Z","caller":"traceutil/trace.go:172","msg":"trace[842731359] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:642; }","duration":"986.693608ms","start":"2026-06-08T15:46:21.498020Z","end":"2026-06-08T15:46:22.484714Z","steps":["trace[842731359] 'read index received' (duration: 986.682878ms)","trace[842731359] 'applied index is now lower than readState.Index' (duration: 9.34µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:22.484884Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"986.846041ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:22.484906Z","caller":"traceutil/trace.go:172","msg":"trace[517146605] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:617; }","duration":"986.887472ms","start":"2026-06-08T15:46:21.498013Z","end":"2026-06-08T15:46:22.484900Z","steps":["trace[517146605] 'agreement among raft nodes before linearized reading' (duration: 986.81673ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:22.485517Z","caller":"traceutil/trace.go:172","msg":"trace[637439112] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"1.037954178s","start":"2026-06-08T15:46:21.447554Z","end":"2026-06-08T15:46:22.485509Z","steps":["trace[637439112] 'process raft request' (duration: 1.037564s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:22.485671Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:21.447526Z","time spent":"1.038059591s","remote":"127.0.0.1:48056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:22.490483Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"398.022646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:22.490542Z","caller":"traceutil/trace.go:172","msg":"trace[1318580401] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"398.092818ms","start":"2026-06-08T15:46:22.092434Z","end":"2026-06-08T15:46:22.490527Z","steps":["trace[1318580401] 'agreement among raft nodes before linearized reading' (duration: 397.979556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:22.490572Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:22.092403Z","time spent":"398.164119ms","remote":"127.0.0.1:47970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:46:22.490542Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"132.995882ms","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-06-08T15:46:22.490708Z","caller":"traceutil/trace.go:172","msg":"trace[115182382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"133.166755ms","start":"2026-06-08T15:46:22.357529Z","end":"2026-06-08T15:46:22.490696Z","steps":["trace[115182382] 'agreement among raft nodes before linearized reading' (duration: 132.90866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:22.490866Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"146.177953ms","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-06-08T15:46:22.490909Z","caller":"traceutil/trace.go:172","msg":"trace[1030940845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:618; }","duration":"146.234464ms","start":"2026-06-08T15:46:22.344668Z","end":"2026-06-08T15:46:22.490902Z","steps":["trace[1030940845] 'agreement among raft nodes before linearized reading' (duration: 145.935588ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:22.491128Z","caller":"traceutil/trace.go:172","msg":"trace[1609329298] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"158.063709ms","start":"2026-06-08T15:46:22.333055Z","end":"2026-06-08T15:46:22.491119Z","steps":["trace[1609329298] 'process raft request' (duration: 158.036649ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:22.491230Z","caller":"traceutil/trace.go:172","msg":"trace[1027876286] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"982.740255ms","start":"2026-06-08T15:46:21.508483Z","end":"2026-06-08T15:46:22.491223Z","steps":["trace[1027876286] 'process raft request' (duration: 981.99724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:22.491350Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:21.508462Z","time spent":"982.851818ms","remote":"127.0.0.1:48056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T15:46:22.491407Z","caller":"traceutil/trace.go:172","msg":"trace[1614496962] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"940.281086ms","start":"2026-06-08T15:46:21.551104Z","end":"2026-06-08T15:46:22.491385Z","steps":["trace[1614496962] 'process raft request' (duration: 939.95671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:22.491482Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:21.551080Z","time spent":"940.365977ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:28.997658Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495136,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T15:46:29.052640Z","caller":"traceutil/trace.go:172","msg":"trace[1999947260] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:679; }","duration":"555.088022ms","start":"2026-06-08T15:46:28.497527Z","end":"2026-06-08T15:46:29.052615Z","steps":["trace[1999947260] 'read index received' (duration: 555.079452ms)","trace[1999947260] 'applied index is now lower than readState.Index' (duration: 7.19µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:29.052766Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"555.222361ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:29.052786Z","caller":"traceutil/trace.go:172","msg":"trace[817648240] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:653; }","duration":"555.260661ms","start":"2026-06-08T15:46:28.497519Z","end":"2026-06-08T15:46:29.052780Z","steps":["trace[817648240] 'agreement among raft nodes before linearized reading' (duration: 555.194781ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:29.053411Z","caller":"traceutil/trace.go:172","msg":"trace[841589026] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"675.598895ms","start":"2026-06-08T15:46:28.377792Z","end":"2026-06-08T15:46:29.053391Z","steps":["trace[841589026] 'process raft request' (duration: 675.06425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:29.053556Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:28.377767Z","time spent":"675.718975ms","remote":"127.0.0.1:48154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:29.073440Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"555.165966ms","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-06-08T15:46:29.073525Z","caller":"traceutil/trace.go:172","msg":"trace[106638921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:654; }","duration":"555.267165ms","start":"2026-06-08T15:46:28.518240Z","end":"2026-06-08T15:46:29.073507Z","steps":["trace[106638921] 'agreement among raft nodes before linearized reading' (duration: 555.027397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:29.073561Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:28.518221Z","time spent":"555.332224ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-06-08T15:46:29.073870Z","caller":"traceutil/trace.go:172","msg":"trace[561467447] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"565.652542ms","start":"2026-06-08T15:46:28.508208Z","end":"2026-06-08T15:46:29.073860Z","steps":["trace[561467447] 'process raft request' (duration: 565.619492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:29.073948Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:28.508184Z","time spent":"565.715434ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:29.074090Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"553.325749ms","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-06-08T15:46:29.074116Z","caller":"traceutil/trace.go:172","msg":"trace[244619022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:656; }","duration":"553.351659ms","start":"2026-06-08T15:46:28.520758Z","end":"2026-06-08T15:46:29.074110Z","steps":["trace[244619022] 'agreement among raft nodes before linearized reading' (duration: 553.28367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:29.074131Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:28.520747Z","time spent":"553.379619ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-06-08T15:46:29.074311Z","caller":"traceutil/trace.go:172","msg":"trace[643677887] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"566.100048ms","start":"2026-06-08T15:46:28.508203Z","end":"2026-06-08T15:46:29.074303Z","steps":["trace[643677887] 'process raft request' (duration: 565.555663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:29.074358Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:28.508179Z","time spent":"566.15692ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:29.284414Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"135.05047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:46:29.284524Z","caller":"traceutil/trace.go:172","msg":"trace[1551733319] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"176.62306ms","start":"2026-06-08T15:46:29.107882Z","end":"2026-06-08T15:46:29.284505Z","steps":["trace[1551733319] 'process raft request' (duration: 41.298063ms)","trace[1551733319] 'compare' (duration: 134.935041ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:30.555837Z","caller":"traceutil/trace.go:172","msg":"trace[846060389] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:693; }","duration":"462.526176ms","start":"2026-06-08T15:46:30.093284Z","end":"2026-06-08T15:46:30.555810Z","steps":["trace[846060389] 'read index received' (duration: 462.513986ms)","trace[846060389] 'applied index is now lower than readState.Index' (duration: 10.42µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:30.556028Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"462.728534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:30.556098Z","caller":"traceutil/trace.go:172","msg":"trace[1232568611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:667; }","duration":"462.810454ms","start":"2026-06-08T15:46:30.093272Z","end":"2026-06-08T15:46:30.556082Z","steps":["trace[1232568611] 'agreement among raft nodes before linearized reading' (duration: 462.684995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:30.556141Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:30.093254Z","time spent":"462.879203ms","remote":"127.0.0.1:47984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-08T15:46:30.556258Z","caller":"traceutil/trace.go:172","msg":"trace[1268981028] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"928.604966ms","start":"2026-06-08T15:46:29.627636Z","end":"2026-06-08T15:46:30.556241Z","steps":["trace[1268981028] 'process raft request' (duration: 928.215099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:30.556379Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:29.627605Z","time spent":"928.697236ms","remote":"127.0.0.1:48326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18507,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:31.592149Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:46:32.092954Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:46:32.594012Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:46:33.091203Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000068032s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-08T15:46:33.091305Z","caller":"traceutil/trace.go:172","msg":"trace[1572073879] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000194391s","start":"2026-06-08T15:46:31.091090Z","end":"2026-06-08T15:46:33.091284Z","steps":["trace[1572073879] 'agreement among raft nodes before linearized reading' (duration: 2.000064682s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:33.091377Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:31.091071Z","time spent":"2.00029289s","remote":"127.0.0.1:47970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:46:33.095158Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:46:33.596144Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:46:34.096806Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:46:34.125074Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"3.313496838s","expected-duration":"1s"} {"level":"info","ts":"2026-06-08T15:46:34.125384Z","caller":"traceutil/trace.go:172","msg":"trace[780710044] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:694; }","duration":"3.034231946s","start":"2026-06-08T15:46:31.091102Z","end":"2026-06-08T15:46:34.125334Z","steps":["trace[780710044] 'read index received' (duration: 3.034210066s)","trace[780710044] 'applied index is now lower than readState.Index' (duration: 18.62µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:34.125574Z","caller":"traceutil/trace.go:172","msg":"trace[826331706] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"3.314160562s","start":"2026-06-08T15:46:30.811394Z","end":"2026-06-08T15:46:34.125555Z","steps":["trace[826331706] 'process raft request' (duration: 3.313997874s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:34.125694Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:30.811344Z","time spent":"3.314276533s","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:34.132714Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.040456775s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:46:34.132778Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.635384021s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:34.132800Z","caller":"traceutil/trace.go:172","msg":"trace[1616271328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:669; }","duration":"1.040558414s","start":"2026-06-08T15:46:33.092225Z","end":"2026-06-08T15:46:34.132784Z","steps":["trace[1616271328] 'agreement among raft nodes before linearized reading' (duration: 1.040416816s)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:34.132807Z","caller":"traceutil/trace.go:172","msg":"trace[180550208] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:669; }","duration":"2.63540823s","start":"2026-06-08T15:46:31.497388Z","end":"2026-06-08T15:46:34.132796Z","steps":["trace[180550208] 'agreement among raft nodes before linearized reading' (duration: 2.635373211s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:34.132833Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:33.092206Z","time spent":"1.040621114s","remote":"127.0.0.1:47984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:46:34.132734Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.033253752s","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-06-08T15:46:34.133107Z","caller":"traceutil/trace.go:172","msg":"trace[718555108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:669; }","duration":"3.033633159s","start":"2026-06-08T15:46:31.099466Z","end":"2026-06-08T15:46:34.133099Z","steps":["trace[718555108] 'agreement among raft nodes before linearized reading' (duration: 3.033137273s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:34.133133Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:31.099445Z","time spent":"3.033679558s","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:46:34.133130Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.762928248s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.195\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-08T15:46:34.133161Z","caller":"traceutil/trace.go:172","msg":"trace[1705233822] range","detail":"{range_begin:/registry/masterleases/199.19.213.195; range_end:; response_count:1; response_revision:669; }","duration":"2.762960998s","start":"2026-06-08T15:46:31.370191Z","end":"2026-06-08T15:46:34.133152Z","steps":["trace[1705233822] 'agreement among raft nodes before linearized reading' (duration: 2.762859779s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:34.133180Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:31.370163Z","time spent":"2.763012028s","remote":"127.0.0.1:48022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.195\" limit:1 "} {"level":"info","ts":"2026-06-08T15:46:34.133396Z","caller":"traceutil/trace.go:172","msg":"trace[902364080] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"3.053043247s","start":"2026-06-08T15:46:31.080345Z","end":"2026-06-08T15:46:34.133389Z","steps":["trace[902364080] 'process raft request' (duration: 3.052689619s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:34.133432Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"812.801566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:34.133494Z","caller":"traceutil/trace.go:172","msg":"trace[1601280476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:669; }","duration":"812.874255ms","start":"2026-06-08T15:46:33.320609Z","end":"2026-06-08T15:46:34.133484Z","steps":["trace[1601280476] 'agreement among raft nodes before linearized reading' (duration: 812.465928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:34.133521Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:33.320594Z","time spent":"812.921215ms","remote":"127.0.0.1:47970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-08T15:46:34.133531Z","caller":"traceutil/trace.go:172","msg":"trace[1472934070] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"3.052945829s","start":"2026-06-08T15:46:31.080577Z","end":"2026-06-08T15:46:34.133523Z","steps":["trace[1472934070] 'process raft request' (duration: 3.05278619s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:34.133587Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:31.080568Z","time spent":"3.052989168s","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:34.133469Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:31.080322Z","time spent":"3.053100767s","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:34.133400Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.030991234s","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-06-08T15:46:34.133657Z","caller":"traceutil/trace.go:172","msg":"trace[1163973838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:669; }","duration":"3.031251591s","start":"2026-06-08T15:46:31.102399Z","end":"2026-06-08T15:46:34.133651Z","steps":["trace[1163973838] 'agreement among raft nodes before linearized reading' (duration: 3.030916195s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:34.133677Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:31.102391Z","time spent":"3.031280621s","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-06-08T15:46:38.816971Z","caller":"traceutil/trace.go:172","msg":"trace[84253781] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"127.740753ms","start":"2026-06-08T15:46:38.689214Z","end":"2026-06-08T15:46:38.816955Z","steps":["trace[84253781] 'process raft request' (duration: 119.986633ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:40.216000Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495242,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T15:46:40.463168Z","caller":"traceutil/trace.go:172","msg":"trace[1064170820] linearizableReadLoop","detail":"{readStateIndex:738; appliedIndex:738; }","duration":"747.548963ms","start":"2026-06-08T15:46:39.715577Z","end":"2026-06-08T15:46:40.463126Z","steps":["trace[1064170820] 'read index received' (duration: 747.539653ms)","trace[1064170820] 'applied index is now lower than readState.Index' (duration: 7.83µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:40.463407Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"747.694082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:40.463476Z","caller":"traceutil/trace.go:172","msg":"trace[1584520184] range","detail":"{range_begin:/registry/validatingadmissionpolicies; range_end:; response_count:0; response_revision:710; }","duration":"747.894342ms","start":"2026-06-08T15:46:39.715573Z","end":"2026-06-08T15:46:40.463467Z","steps":["trace[1584520184] 'agreement among raft nodes before linearized reading' (duration: 747.655023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:40.463627Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:39.715562Z","time spent":"748.050521ms","remote":"127.0.0.1:49040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/validatingadmissionpolicies\" limit:1 "} {"level":"info","ts":"2026-06-08T15:46:40.464028Z","caller":"traceutil/trace.go:172","msg":"trace[883673864] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"752.476892ms","start":"2026-06-08T15:46:39.711532Z","end":"2026-06-08T15:46:40.464009Z","steps":["trace[883673864] 'process raft request' (duration: 752.281293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:40.464182Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:39.711509Z","time spent":"752.602552ms","remote":"127.0.0.1:48326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19890,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:40.599900Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"508.204221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:40.600030Z","caller":"traceutil/trace.go:172","msg":"trace[427716609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:711; }","duration":"508.34784ms","start":"2026-06-08T15:46:40.091654Z","end":"2026-06-08T15:46:40.600002Z","steps":["trace[427716609] 'agreement among raft nodes before linearized reading' (duration: 430.545148ms)","trace[427716609] 'range keys from in-memory index tree' (duration: 77.619875ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:40.600086Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:40.091632Z","time spent":"508.4415ms","remote":"127.0.0.1:47970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:46:40.600470Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"429.882901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-08T15:46:40.600476Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"439.653606ms","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-06-08T15:46:40.600557Z","caller":"traceutil/trace.go:172","msg":"trace[1078766075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:711; }","duration":"429.974862ms","start":"2026-06-08T15:46:40.170553Z","end":"2026-06-08T15:46:40.600528Z","steps":["trace[1078766075] 'agreement among raft nodes before linearized reading' (duration: 351.644502ms)","trace[1078766075] 'range keys from in-memory index tree' (duration: 78.023122ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:40.600577Z","caller":"traceutil/trace.go:172","msg":"trace[1359586344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:711; }","duration":"439.798265ms","start":"2026-06-08T15:46:40.160755Z","end":"2026-06-08T15:46:40.600553Z","steps":["trace[1359586344] 'agreement among raft nodes before linearized reading' (duration: 361.465655ms)","trace[1359586344] 'range keys from in-memory index tree' (duration: 77.977332ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:40.600544Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"236.241813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:81 size:6864"} {"level":"warn","ts":"2026-06-08T15:46:40.600626Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:40.160739Z","time spent":"439.877295ms","remote":"127.0.0.1:48452","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-06-08T15:46:40.600659Z","caller":"traceutil/trace.go:172","msg":"trace[600550275] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:81; response_revision:711; }","duration":"236.386513ms","start":"2026-06-08T15:46:40.364249Z","end":"2026-06-08T15:46:40.600635Z","steps":["trace[600550275] 'agreement among raft nodes before linearized reading' (duration: 157.969773ms)","trace[600550275] 'range keys from in-memory index tree' (duration: 77.686964ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:40.600602Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:40.170543Z","time spent":"430.046551ms","remote":"127.0.0.1:48452","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-06-08T15:46:40.600946Z","caller":"traceutil/trace.go:172","msg":"trace[1035839498] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"445.264743ms","start":"2026-06-08T15:46:40.155670Z","end":"2026-06-08T15:46:40.600934Z","steps":["trace[1035839498] 'process raft request' (duration: 445.025604ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:40.600970Z","caller":"traceutil/trace.go:172","msg":"trace[1867188884] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"446.120288ms","start":"2026-06-08T15:46:40.154818Z","end":"2026-06-08T15:46:40.600939Z","steps":["trace[1867188884] 'process raft request' (duration: 367.4209ms)","trace[1867188884] 'compare' (duration: 77.389985ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:40.601031Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:40.155660Z","time spent":"445.315312ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:40.601121Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:40.154794Z","time spent":"446.248167ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:46:42.182573Z","caller":"traceutil/trace.go:172","msg":"trace[1214371991] linearizableReadLoop","detail":"{readStateIndex:782; appliedIndex:782; }","duration":"162.48793ms","start":"2026-06-08T15:46:42.020053Z","end":"2026-06-08T15:46:42.182541Z","steps":["trace[1214371991] 'read index received' (duration: 162.45568ms)","trace[1214371991] 'applied index is now lower than readState.Index' (duration: 9.73µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:42.182829Z","caller":"traceutil/trace.go:172","msg":"trace[295473218] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"462.13027ms","start":"2026-06-08T15:46:41.720678Z","end":"2026-06-08T15:46:42.182808Z","steps":["trace[295473218] 'process raft request' (duration: 461.96084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:42.182959Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:41.720645Z","time spent":"462.22991ms","remote":"127.0.0.1:48326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20071,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:42.182951Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"162.825989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:42.183146Z","caller":"traceutil/trace.go:172","msg":"trace[1129633413] range","detail":"{range_begin:/registry/roles; range_end:; response_count:0; response_revision:753; }","duration":"163.074247ms","start":"2026-06-08T15:46:42.020048Z","end":"2026-06-08T15:46:42.183122Z","steps":["trace[1129633413] 'agreement among raft nodes before linearized reading' (duration: 162.68828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:42.218802Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"127.171041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:42.218881Z","caller":"traceutil/trace.go:172","msg":"trace[1874290697] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:753; }","duration":"127.264441ms","start":"2026-06-08T15:46:42.091601Z","end":"2026-06-08T15:46:42.218865Z","steps":["trace[1874290697] 'agreement among raft nodes before linearized reading' (duration: 127.097092ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:42.219084Z","caller":"traceutil/trace.go:172","msg":"trace[1653544329] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"172.126681ms","start":"2026-06-08T15:46:42.046930Z","end":"2026-06-08T15:46:42.219056Z","steps":["trace[1653544329] 'process raft request' (duration: 172.039161ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:42.219342Z","caller":"traceutil/trace.go:172","msg":"trace[1041052962] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"373.591362ms","start":"2026-06-08T15:46:41.845706Z","end":"2026-06-08T15:46:42.219297Z","steps":["trace[1041052962] 'process raft request' (duration: 373.104904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:42.219503Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:41.845686Z","time spent":"373.756431ms","remote":"127.0.0.1:48056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T15:46:43.051152Z","caller":"traceutil/trace.go:172","msg":"trace[856023243] linearizableReadLoop","detail":"{readStateIndex:800; appliedIndex:800; }","duration":"190.463982ms","start":"2026-06-08T15:46:42.860670Z","end":"2026-06-08T15:46:43.051134Z","steps":["trace[856023243] 'read index received' (duration: 190.457402ms)","trace[856023243] 'applied index is now lower than readState.Index' (duration: 5.56µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:43.051373Z","caller":"traceutil/trace.go:172","msg":"trace[224985321] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"201.649214ms","start":"2026-06-08T15:46:42.849703Z","end":"2026-06-08T15:46:43.051352Z","steps":["trace[224985321] 'process raft request' (duration: 201.493695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:43.051502Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"190.817579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-08T15:46:43.051535Z","caller":"traceutil/trace.go:172","msg":"trace[34252677] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:770; }","duration":"190.86696ms","start":"2026-06-08T15:46:42.860657Z","end":"2026-06-08T15:46:43.051524Z","steps":["trace[34252677] 'agreement among raft nodes before linearized reading' (duration: 190.591961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:44.372436Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.046979ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:46:44.372529Z","caller":"traceutil/trace.go:172","msg":"trace[598199668] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:806; }","duration":"110.626743ms","start":"2026-06-08T15:46:44.261888Z","end":"2026-06-08T15:46:44.372514Z","steps":["trace[598199668] 'read index received' (duration: 40.7µs)","trace[598199668] 'applied index is now lower than readState.Index' (duration: 110.584983ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:44.372710Z","caller":"traceutil/trace.go:172","msg":"trace[2139225926] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"183.827695ms","start":"2026-06-08T15:46:44.188843Z","end":"2026-06-08T15:46:44.372671Z","steps":["trace[2139225926] 'process raft request' (duration: 67.466308ms)","trace[2139225926] 'compare' (duration: 115.824089ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:44.372755Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.842183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:44.373013Z","caller":"traceutil/trace.go:172","msg":"trace[860808752] range","detail":"{range_begin:/registry/poddisruptionbudgets; range_end:; response_count:0; response_revision:777; }","duration":"111.106111ms","start":"2026-06-08T15:46:44.261883Z","end":"2026-06-08T15:46:44.372990Z","steps":["trace[860808752] 'agreement among raft nodes before linearized reading' (duration: 110.776833ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:44.720600Z","caller":"traceutil/trace.go:172","msg":"trace[1140877337] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"106.172633ms","start":"2026-06-08T15:46:44.614396Z","end":"2026-06-08T15:46:44.720568Z","steps":["trace[1140877337] 'process raft request' (duration: 42.461669ms)","trace[1140877337] 'compare' (duration: 63.558704ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:44.778432Z","caller":"traceutil/trace.go:172","msg":"trace[809059001] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:811; }","duration":"121.639282ms","start":"2026-06-08T15:46:44.656772Z","end":"2026-06-08T15:46:44.778411Z","steps":["trace[809059001] 'read index received' (duration: 121.631213ms)","trace[809059001] 'applied index is now lower than readState.Index' (duration: 6.839µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:44.778629Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"125.367667ms","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-06-08T15:46:44.778661Z","caller":"traceutil/trace.go:172","msg":"trace[665289874] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:781; }","duration":"125.417647ms","start":"2026-06-08T15:46:44.653236Z","end":"2026-06-08T15:46:44.778654Z","steps":["trace[665289874] 'agreement among raft nodes before linearized reading' (duration: 125.269367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:44.778794Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"130.049506ms","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-06-08T15:46:44.778847Z","caller":"traceutil/trace.go:172","msg":"trace[960390868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:782; }","duration":"130.097076ms","start":"2026-06-08T15:46:44.648728Z","end":"2026-06-08T15:46:44.778825Z","steps":["trace[960390868] 'agreement among raft nodes before linearized reading' (duration: 129.821907ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:44.778870Z","caller":"traceutil/trace.go:172","msg":"trace[1925633806] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"164.297642ms","start":"2026-06-08T15:46:44.614563Z","end":"2026-06-08T15:46:44.778861Z","steps":["trace[1925633806] 'process raft request' (duration: 163.932233ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:44.778943Z","caller":"traceutil/trace.go:172","msg":"trace[1597797288] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"140.12997ms","start":"2026-06-08T15:46:44.638805Z","end":"2026-06-08T15:46:44.778935Z","steps":["trace[1597797288] 'process raft request' (duration: 139.861282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:45.064927Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49762","server-name":"","error":"EOF"} {"level":"info","ts":"2026-06-08T15:46:45.169675Z","caller":"traceutil/trace.go:172","msg":"trace[450477300] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"100.892607ms","start":"2026-06-08T15:46:45.068736Z","end":"2026-06-08T15:46:45.169629Z","steps":["trace[450477300] 'process raft request' (duration: 47.033043ms)","trace[450477300] 'compare' (duration: 53.619196ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:45.911256Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34302","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:45.923765Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34334","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:46.044553Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34338","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:46.071845Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34348","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:46.205693Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34372","server-name":"","error":"EOF"} {"level":"info","ts":"2026-06-08T15:46:46.252759Z","caller":"traceutil/trace.go:172","msg":"trace[1717116694] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"138.286701ms","start":"2026-06-08T15:46:46.114451Z","end":"2026-06-08T15:46:46.252738Z","steps":["trace[1717116694] 'process raft request' (duration: 138.223041ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:46.252786Z","caller":"traceutil/trace.go:172","msg":"trace[11971967] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"139.899016ms","start":"2026-06-08T15:46:46.112839Z","end":"2026-06-08T15:46:46.252738Z","steps":["trace[11971967] 'process raft request' (duration: 139.660037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:46.488089Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"268.564634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:46.488183Z","caller":"traceutil/trace.go:172","msg":"trace[603307150] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:793; }","duration":"268.676284ms","start":"2026-06-08T15:46:46.219486Z","end":"2026-06-08T15:46:46.488163Z","steps":["trace[603307150] 'agreement among raft nodes before linearized reading' (duration: 100.707899ms)","trace[603307150] 'range keys from in-memory index tree' (duration: 167.803726ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:46.488693Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"268.872583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:46.488726Z","caller":"traceutil/trace.go:172","msg":"trace[484980599] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities; range_end:; response_count:0; response_revision:793; }","duration":"268.906822ms","start":"2026-06-08T15:46:46.219809Z","end":"2026-06-08T15:46:46.488716Z","steps":["trace[484980599] 'agreement among raft nodes before linearized reading' (duration: 100.3576ms)","trace[484980599] 'range keys from in-memory index tree' (duration: 168.489853ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:46.488914Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"168.582153ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:46:46.489092Z","caller":"traceutil/trace.go:172","msg":"trace[109165051] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"168.944482ms","start":"2026-06-08T15:46:46.320125Z","end":"2026-06-08T15:46:46.489070Z","steps":["trace[109165051] 'read index received' (duration: 64.05µs)","trace[109165051] 'applied index is now lower than readState.Index' (duration: 168.877982ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:46.489271Z","caller":"traceutil/trace.go:172","msg":"trace[426403385] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"307.974071ms","start":"2026-06-08T15:46:46.181284Z","end":"2026-06-08T15:46:46.489258Z","steps":["trace[426403385] 'process raft request' (duration: 138.966439ms)","trace[426403385] 'compare' (duration: 167.685046ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:46.489404Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:46.181264Z","time spent":"308.0977ms","remote":"127.0.0.1:48124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":860,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T15:46:46.489623Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"195.29605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:46.489653Z","caller":"traceutil/trace.go:172","msg":"trace[111288487] range","detail":"{range_begin:/registry/clusterroles; range_end:; response_count:0; response_revision:794; }","duration":"195.35396ms","start":"2026-06-08T15:46:46.294293Z","end":"2026-06-08T15:46:46.489647Z","steps":["trace[111288487] 'agreement among raft nodes before linearized reading' (duration: 195.27609ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:47.054661Z","caller":"traceutil/trace.go:172","msg":"trace[1839908820] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:825; }","duration":"197.226946ms","start":"2026-06-08T15:46:46.857397Z","end":"2026-06-08T15:46:47.054624Z","steps":["trace[1839908820] 'read index received' (duration: 197.218687ms)","trace[1839908820] 'applied index is now lower than readState.Index' (duration: 7.409µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:47.054844Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"197.422706ms","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-06-08T15:46:47.054875Z","caller":"traceutil/trace.go:172","msg":"trace[1504037128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:795; }","duration":"197.475375ms","start":"2026-06-08T15:46:46.857392Z","end":"2026-06-08T15:46:47.054867Z","steps":["trace[1504037128] 'agreement among raft nodes before linearized reading' (duration: 197.341726ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:47.054866Z","caller":"traceutil/trace.go:172","msg":"trace[1702028773] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"327.249719ms","start":"2026-06-08T15:46:46.727598Z","end":"2026-06-08T15:46:47.054848Z","steps":["trace[1702028773] 'process raft request' (duration: 327.11428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.054996Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:46.727589Z","time spent":"327.336869ms","remote":"127.0.0.1:48124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":784,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:47.286655Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34406","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.301104Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34412","server-name":"","error":"EOF"} {"level":"info","ts":"2026-06-08T15:46:47.370352Z","caller":"traceutil/trace.go:172","msg":"trace[865155101] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:826; }","duration":"315.606223ms","start":"2026-06-08T15:46:47.054717Z","end":"2026-06-08T15:46:47.370323Z","steps":["trace[865155101] 'read index received' (duration: 315.592163ms)","trace[865155101] 'applied index is now lower than readState.Index' (duration: 11.78µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:47.385536Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"528.004924ms","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-06-08T15:46:47.385626Z","caller":"traceutil/trace.go:172","msg":"trace[229530754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:796; }","duration":"528.106234ms","start":"2026-06-08T15:46:46.857500Z","end":"2026-06-08T15:46:47.385606Z","steps":["trace[229530754] 'agreement among raft nodes before linearized reading' (duration: 512.971359ms)","trace[229530754] 'range keys from in-memory index tree' (duration: 14.914006ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:47.385554Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"374.65608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:46:47.385665Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:46.857470Z","time spent":"528.185995ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-06-08T15:46:47.385747Z","caller":"traceutil/trace.go:172","msg":"trace[62044580] range","detail":"{range_begin:/registry/runtimeclasses; range_end:; response_count:0; response_revision:796; }","duration":"374.83925ms","start":"2026-06-08T15:46:47.010863Z","end":"2026-06-08T15:46:47.385702Z","steps":["trace[62044580] 'agreement among raft nodes before linearized reading' (duration: 359.592365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.385825Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:47.010845Z","time spent":"374.968229ms","remote":"127.0.0.1:48568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses\" limit:1 "} {"level":"info","ts":"2026-06-08T15:46:47.385874Z","caller":"traceutil/trace.go:172","msg":"trace[265410984] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"600.865231ms","start":"2026-06-08T15:46:46.784992Z","end":"2026-06-08T15:46:47.385858Z","steps":["trace[265410984] 'process raft request' (duration: 585.469646ms)","trace[265410984] 'compare' (duration: 14.997086ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:47.385921Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"292.256147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:47.385956Z","caller":"traceutil/trace.go:172","msg":"trace[1653767172] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"292.289117ms","start":"2026-06-08T15:46:47.093657Z","end":"2026-06-08T15:46:47.385946Z","steps":["trace[1653767172] 'agreement among raft nodes before linearized reading' (duration: 292.230727ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:47.385743Z","caller":"traceutil/trace.go:172","msg":"trace[1681590195] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"326.574384ms","start":"2026-06-08T15:46:47.059140Z","end":"2026-06-08T15:46:47.385715Z","steps":["trace[1681590195] 'process raft request' (duration: 326.493975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.385996Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.513915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:47.386044Z","caller":"traceutil/trace.go:172","msg":"trace[626124669] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities; range_end:; response_count:0; response_revision:798; }","duration":"109.565555ms","start":"2026-06-08T15:46:47.276472Z","end":"2026-06-08T15:46:47.386037Z","steps":["trace[626124669] 'agreement among raft nodes before linearized reading' (duration: 109.469315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.386050Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"190.739462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:47.386153Z","caller":"traceutil/trace.go:172","msg":"trace[2018539778] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies; range_end:; response_count:0; response_revision:798; }","duration":"190.842311ms","start":"2026-06-08T15:46:47.195281Z","end":"2026-06-08T15:46:47.386123Z","steps":["trace[2018539778] 'agreement among raft nodes before linearized reading' (duration: 190.663812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.386164Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"190.937231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:46:47.386116Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:47.059114Z","time spent":"326.908252ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:46:47.386195Z","caller":"traceutil/trace.go:172","msg":"trace[1364538520] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints; range_end:; response_count:0; response_revision:798; }","duration":"190.968701ms","start":"2026-06-08T15:46:47.195218Z","end":"2026-06-08T15:46:47.386187Z","steps":["trace[1364538520] 'agreement among raft nodes before linearized reading' (duration: 190.918031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.386385Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.774395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:47.386411Z","caller":"traceutil/trace.go:172","msg":"trace[1885396722] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies; range_end:; response_count:0; response_revision:798; }","duration":"109.800515ms","start":"2026-06-08T15:46:47.276603Z","end":"2026-06-08T15:46:47.386404Z","steps":["trace[1885396722] 'agreement among raft nodes before linearized reading' (duration: 109.761825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.386458Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.153594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:47.386496Z","caller":"traceutil/trace.go:172","msg":"trace[2041957675] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes; range_end:; response_count:0; response_revision:798; }","duration":"110.190433ms","start":"2026-06-08T15:46:47.276297Z","end":"2026-06-08T15:46:47.386487Z","steps":["trace[2041957675] 'agreement among raft nodes before linearized reading' (duration: 110.138124ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.386298Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"211.546517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-08T15:46:47.386460Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.078544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:47.386600Z","caller":"traceutil/trace.go:172","msg":"trace[1358866509] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"211.842997ms","start":"2026-06-08T15:46:47.174744Z","end":"2026-06-08T15:46:47.386587Z","steps":["trace[1358866509] 'agreement among raft nodes before linearized reading' (duration: 211.467908ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:47.386643Z","caller":"traceutil/trace.go:172","msg":"trace[1424917337] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools; range_end:; response_count:0; response_revision:798; }","duration":"110.252983ms","start":"2026-06-08T15:46:47.276374Z","end":"2026-06-08T15:46:47.386627Z","steps":["trace[1424917337] 'agreement among raft nodes before linearized reading' (duration: 110.037874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.387088Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:46.784972Z","time spent":"600.93929ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:47.435535Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34434","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.509624Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34458","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.583556Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34470","server-name":"","error":"EOF"} {"level":"info","ts":"2026-06-08T15:46:47.600021Z","caller":"traceutil/trace.go:172","msg":"trace[571609026] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:828; }","duration":"156.725355ms","start":"2026-06-08T15:46:47.443271Z","end":"2026-06-08T15:46:47.599996Z","steps":["trace[571609026] 'read index received' (duration: 156.716725ms)","trace[571609026] 'applied index is now lower than readState.Index' (duration: 7.31µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:47.608978Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34488","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.639862Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"196.570042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:47.639933Z","caller":"traceutil/trace.go:172","msg":"trace[1515048161] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies; range_end:; response_count:0; response_revision:798; }","duration":"196.650461ms","start":"2026-06-08T15:46:47.443265Z","end":"2026-06-08T15:46:47.639916Z","steps":["trace[1515048161] 'agreement among raft nodes before linearized reading' (duration: 156.866594ms)","trace[1515048161] 'range keys from in-memory index tree' (duration: 39.662338ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:47.640148Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"142.943654ms","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-06-08T15:46:47.640167Z","caller":"traceutil/trace.go:172","msg":"trace[191839005] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:798; }","duration":"142.964444ms","start":"2026-06-08T15:46:47.497198Z","end":"2026-06-08T15:46:47.640162Z","steps":["trace[191839005] 'range keys from in-memory index tree' (duration: 142.913655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.640398Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"197.125539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:47.640420Z","caller":"traceutil/trace.go:172","msg":"trace[127824133] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:798; }","duration":"197.147909ms","start":"2026-06-08T15:46:47.443265Z","end":"2026-06-08T15:46:47.640413Z","steps":["trace[127824133] 'agreement among raft nodes before linearized reading' (duration: 156.829435ms)","trace[127824133] 'range keys from in-memory index tree' (duration: 40.265444ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:47.640705Z","caller":"traceutil/trace.go:172","msg":"trace[624940739] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"249.81111ms","start":"2026-06-08T15:46:47.390882Z","end":"2026-06-08T15:46:47.640693Z","steps":["trace[624940739] 'process raft request' (duration: 209.202547ms)","trace[624940739] 'compare' (duration: 40.237374ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:47.641190Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"105.433391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:47.641215Z","caller":"traceutil/trace.go:172","msg":"trace[1912962853] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:800; }","duration":"105.460081ms","start":"2026-06-08T15:46:47.535749Z","end":"2026-06-08T15:46:47.641210Z","steps":["trace[1912962853] 'agreement among raft nodes before linearized reading' (duration: 105.028182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.641293Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"105.5652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:47.641313Z","caller":"traceutil/trace.go:172","msg":"trace[2074833958] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes; range_end:; response_count:0; response_revision:800; }","duration":"105.58312ms","start":"2026-06-08T15:46:47.535723Z","end":"2026-06-08T15:46:47.641306Z","steps":["trace[2074833958] 'agreement among raft nodes before linearized reading' (duration: 105.063342ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:47.641378Z","caller":"traceutil/trace.go:172","msg":"trace[270287158] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"249.585691ms","start":"2026-06-08T15:46:47.391787Z","end":"2026-06-08T15:46:47.641373Z","steps":["trace[270287158] 'process raft request' (duration: 248.751354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.731009Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34514","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.790523Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34536","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.812483Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34556","server-name":"","error":"EOF"} {"level":"info","ts":"2026-06-08T15:46:47.815432Z","caller":"traceutil/trace.go:172","msg":"trace[366407356] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"160.243272ms","start":"2026-06-08T15:46:47.655172Z","end":"2026-06-08T15:46:47.815415Z","steps":["trace[366407356] 'process raft request' (duration: 98.822164ms)","trace[366407356] 'compare' (duration: 61.314939ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:47.819060Z","caller":"traceutil/trace.go:172","msg":"trace[662643843] transaction","detail":"{read_only:false; number_of_response:0; response_revision:801; }","duration":"160.118003ms","start":"2026-06-08T15:46:47.658931Z","end":"2026-06-08T15:46:47.819049Z","steps":["trace[662643843] 'process raft request' (duration: 159.897513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:47.868114Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34582","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.901350Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34600","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.925878Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34622","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.952161Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34634","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.966519Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34638","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:47.998759Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34660","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.038512Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34680","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.058792Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34708","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.083055Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34730","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.105168Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34742","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.156941Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34774","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.173765Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34800","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.186525Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34810","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.201351Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34842","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.216471Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34858","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.235610Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34894","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.246299Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34906","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-06-08T15:46:48.256259Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34934","server-name":"","error":"EOF"} {"level":"info","ts":"2026-06-08T15:46:49.832588Z","caller":"traceutil/trace.go:172","msg":"trace[677982403] linearizableReadLoop","detail":"{readStateIndex:843; appliedIndex:843; }","duration":"181.59307ms","start":"2026-06-08T15:46:49.650968Z","end":"2026-06-08T15:46:49.832561Z","steps":["trace[677982403] 'read index received' (duration: 181.58724ms)","trace[677982403] 'applied index is now lower than readState.Index' (duration: 5µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:49.832924Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"181.930838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-08T15:46:49.832979Z","caller":"traceutil/trace.go:172","msg":"trace[920504597] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:811; }","duration":"182.011367ms","start":"2026-06-08T15:46:49.650956Z","end":"2026-06-08T15:46:49.832967Z","steps":["trace[920504597] 'agreement among raft nodes before linearized reading' (duration: 181.727698ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:49.833633Z","caller":"traceutil/trace.go:172","msg":"trace[204349118] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"183.381203ms","start":"2026-06-08T15:46:49.650234Z","end":"2026-06-08T15:46:49.833615Z","steps":["trace[204349118] 'process raft request' (duration: 182.253457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:49.839803Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"142.410708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:49.839841Z","caller":"traceutil/trace.go:172","msg":"trace[1378119363] range","detail":"{range_begin:/registry/replicasets; range_end:; response_count:0; response_revision:812; }","duration":"142.453078ms","start":"2026-06-08T15:46:49.697378Z","end":"2026-06-08T15:46:49.839831Z","steps":["trace[1378119363] 'agreement among raft nodes before linearized reading' (duration: 142.384718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:49.840268Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"100.385246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/servicecidrs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:49.840349Z","caller":"traceutil/trace.go:172","msg":"trace[476942408] range","detail":"{range_begin:/registry/servicecidrs; range_end:; response_count:0; response_revision:813; }","duration":"100.456556ms","start":"2026-06-08T15:46:49.739863Z","end":"2026-06-08T15:46:49.840320Z","steps":["trace[476942408] 'agreement among raft nodes before linearized reading' (duration: 100.342076ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:51.100000Z","caller":"traceutil/trace.go:172","msg":"trace[703961402] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"350.851549ms","start":"2026-06-08T15:46:50.749127Z","end":"2026-06-08T15:46:51.099978Z","steps":["trace[703961402] 'process raft request' (duration: 350.70319ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:51.099675Z","caller":"traceutil/trace.go:172","msg":"trace[2123174330] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:846; }","duration":"290.714016ms","start":"2026-06-08T15:46:50.808917Z","end":"2026-06-08T15:46:51.099631Z","steps":["trace[2123174330] 'read index received' (duration: 290.702386ms)","trace[2123174330] 'applied index is now lower than readState.Index' (duration: 9.84µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:51.100332Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"291.389974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:51.100420Z","caller":"traceutil/trace.go:172","msg":"trace[562774839] range","detail":"{range_begin:/registry/jobs; range_end:; response_count:0; response_revision:815; }","duration":"291.492864ms","start":"2026-06-08T15:46:50.808912Z","end":"2026-06-08T15:46:51.100405Z","steps":["trace[562774839] 'agreement among raft nodes before linearized reading' (duration: 291.296883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:51.100315Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:50.749095Z","time spent":"351.139459ms","remote":"127.0.0.1:48326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20071,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:51.210804Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"396.237435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:51.211032Z","caller":"traceutil/trace.go:172","msg":"trace[1390222540] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"404.055333ms","start":"2026-06-08T15:46:50.806955Z","end":"2026-06-08T15:46:51.211011Z","steps":["trace[1390222540] 'process raft request' (duration: 339.187434ms)","trace[1390222540] 'compare' (duration: 64.582479ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:51.211163Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:50.806937Z","time spent":"404.165633ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:46:51.211480Z","caller":"traceutil/trace.go:172","msg":"trace[1287456837] range","detail":"{range_begin:/registry/namespaces; range_end:; response_count:0; response_revision:815; }","duration":"396.340666ms","start":"2026-06-08T15:46:50.814532Z","end":"2026-06-08T15:46:51.210873Z","steps":["trace[1287456837] 'agreement among raft nodes before linearized reading' (duration: 331.599006ms)","trace[1287456837] 'range keys from in-memory index tree' (duration: 64.591869ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:51.211515Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:50.814510Z","time spent":"396.996572ms","remote":"127.0.0.1:48184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:46:51.211917Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.988145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-95466\" limit:1 ","response":"range_response_count:1 size:20086"} {"level":"info","ts":"2026-06-08T15:46:51.211949Z","caller":"traceutil/trace.go:172","msg":"trace[211955853] range","detail":"{range_begin:/registry/pods/kube-system/cilium-95466; range_end:; response_count:1; response_revision:816; }","duration":"107.022135ms","start":"2026-06-08T15:46:51.104918Z","end":"2026-06-08T15:46:51.211940Z","steps":["trace[211955853] 'agreement among raft nodes before linearized reading' (duration: 106.030178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:52.072021Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"226.386437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-08T15:46:52.072103Z","caller":"traceutil/trace.go:172","msg":"trace[1990110971] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:829; }","duration":"226.488567ms","start":"2026-06-08T15:46:51.845598Z","end":"2026-06-08T15:46:52.072086Z","steps":["trace[1990110971] 'range keys from in-memory index tree' (duration: 226.238616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:52.072131Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"233.804237ms","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-06-08T15:46:52.072237Z","caller":"traceutil/trace.go:172","msg":"trace[1200304856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:829; }","duration":"233.922417ms","start":"2026-06-08T15:46:51.838295Z","end":"2026-06-08T15:46:52.072217Z","steps":["trace[1200304856] 'range keys from in-memory index tree' (duration: 233.631608ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:52.272466Z","caller":"traceutil/trace.go:172","msg":"trace[2121635783] linearizableReadLoop","detail":"{readStateIndex:862; appliedIndex:862; }","duration":"180.69354ms","start":"2026-06-08T15:46:52.091748Z","end":"2026-06-08T15:46:52.272441Z","steps":["trace[2121635783] 'read index received' (duration: 180.68412ms)","trace[2121635783] 'applied index is now lower than readState.Index' (duration: 8.18µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:52.272592Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"180.83538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:52.272614Z","caller":"traceutil/trace.go:172","msg":"trace[325296438] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:829; }","duration":"180.872739ms","start":"2026-06-08T15:46:52.091735Z","end":"2026-06-08T15:46:52.272607Z","steps":["trace[325296438] 'agreement among raft nodes before linearized reading' (duration: 180.79784ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:52.272662Z","caller":"traceutil/trace.go:172","msg":"trace[277686667] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"195.936676ms","start":"2026-06-08T15:46:52.076709Z","end":"2026-06-08T15:46:52.272646Z","steps":["trace[277686667] 'process raft request' (duration: 195.819917ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:52.470809Z","caller":"traceutil/trace.go:172","msg":"trace[1167977038] linearizableReadLoop","detail":"{readStateIndex:863; appliedIndex:863; }","duration":"196.809995ms","start":"2026-06-08T15:46:52.273979Z","end":"2026-06-08T15:46:52.470789Z","steps":["trace[1167977038] 'read index received' (duration: 196.803545ms)","trace[1167977038] 'applied index is now lower than readState.Index' (duration: 5.61µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:52.517528Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"243.530282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:52.517652Z","caller":"traceutil/trace.go:172","msg":"trace[1203610466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:830; }","duration":"243.664221ms","start":"2026-06-08T15:46:52.273975Z","end":"2026-06-08T15:46:52.517639Z","steps":["trace[1203610466] 'agreement among raft nodes before linearized reading' (duration: 196.903875ms)","trace[1203610466] 'range keys from in-memory index tree' (duration: 46.606868ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:52.518437Z","caller":"traceutil/trace.go:172","msg":"trace[859835631] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"441.072483ms","start":"2026-06-08T15:46:52.077340Z","end":"2026-06-08T15:46:52.518412Z","steps":["trace[859835631] 'process raft request' (duration: 393.637389ms)","trace[859835631] 'compare' (duration: 46.545707ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:52.518719Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:52.077308Z","time spent":"441.187323ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":479,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:53.542460Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"128.25988ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:46:53.542542Z","caller":"traceutil/trace.go:172","msg":"trace[1518699459] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"326.491103ms","start":"2026-06-08T15:46:53.216038Z","end":"2026-06-08T15:46:53.542529Z","steps":["trace[1518699459] 'process raft request' (duration: 198.081514ms)","trace[1518699459] 'compare' (duration: 127.95036ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:53.542579Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:53.216008Z","time spent":"326.553933ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:46:53.748476Z","caller":"traceutil/trace.go:172","msg":"trace[824908715] linearizableReadLoop","detail":"{readStateIndex:868; appliedIndex:868; }","duration":"149.626377ms","start":"2026-06-08T15:46:53.598828Z","end":"2026-06-08T15:46:53.748454Z","steps":["trace[824908715] 'read index received' (duration: 149.619857ms)","trace[824908715] 'applied index is now lower than readState.Index' (duration: 5.58µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:53.914565Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"330.540506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:53.914651Z","caller":"traceutil/trace.go:172","msg":"trace[1959725525] range","detail":"{range_begin:/registry/leases; range_end:; response_count:0; response_revision:835; }","duration":"330.630146ms","start":"2026-06-08T15:46:53.584000Z","end":"2026-06-08T15:46:53.914630Z","steps":["trace[1959725525] 'agreement among raft nodes before linearized reading' (duration: 164.530379ms)","trace[1959725525] 'range keys from in-memory index tree' (duration: 165.985897ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:53.914687Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:53.583975Z","time spent":"330.703786ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":20,"response count":0,"response size":28,"request content":"key:\"/registry/leases\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:46:53.914816Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"166.156127ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:46:53.915199Z","caller":"traceutil/trace.go:172","msg":"trace[541974825] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"346.883384ms","start":"2026-06-08T15:46:53.568300Z","end":"2026-06-08T15:46:53.915183Z","steps":["trace[541974825] 'process raft request' (duration: 180.255329ms)","trace[541974825] 'compare' (duration: 165.912017ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:53.915290Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:53.568274Z","time spent":"346.960105ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:53.915424Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"162.356495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-66bc5c9577-9969c\" limit:1 ","response":"range_response_count:1 size:5547"} {"level":"info","ts":"2026-06-08T15:46:53.915478Z","caller":"traceutil/trace.go:172","msg":"trace[1856473073] range","detail":"{range_begin:/registry/pods/kube-system/coredns-66bc5c9577-9969c; range_end:; response_count:1; response_revision:836; }","duration":"162.419384ms","start":"2026-06-08T15:46:53.753049Z","end":"2026-06-08T15:46:53.915468Z","steps":["trace[1856473073] 'agreement among raft nodes before linearized reading' (duration: 162.210595ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:53.915191Z","caller":"traceutil/trace.go:172","msg":"trace[1442847977] linearizableReadLoop","detail":"{readStateIndex:869; appliedIndex:868; }","duration":"162.106174ms","start":"2026-06-08T15:46:53.753061Z","end":"2026-06-08T15:46:53.915167Z","steps":["trace[1442847977] 'read index received' (duration: 41.95µs)","trace[1442847977] 'applied index is now lower than readState.Index' (duration: 162.061734ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:46:55.633853Z","caller":"traceutil/trace.go:172","msg":"trace[860700365] linearizableReadLoop","detail":"{readStateIndex:880; appliedIndex:880; }","duration":"135.130647ms","start":"2026-06-08T15:46:55.498694Z","end":"2026-06-08T15:46:55.633825Z","steps":["trace[860700365] 'read index received' (duration: 135.118127ms)","trace[860700365] 'applied index is now lower than readState.Index' (duration: 10.93µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:55.634065Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"135.351777ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:55.634137Z","caller":"traceutil/trace.go:172","msg":"trace[1870974966] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:847; }","duration":"135.443577ms","start":"2026-06-08T15:46:55.498681Z","end":"2026-06-08T15:46:55.634124Z","steps":["trace[1870974966] 'agreement among raft nodes before linearized reading' (duration: 135.306907ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:55.634225Z","caller":"traceutil/trace.go:172","msg":"trace[732472115] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"233.303956ms","start":"2026-06-08T15:46:55.400894Z","end":"2026-06-08T15:46:55.634198Z","steps":["trace[732472115] 'process raft request' (duration: 233.095416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:58.998431Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495652,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:46:59.498645Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495652,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-08T15:46:59.852149Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.543277851s","expected-duration":"1s"} {"level":"info","ts":"2026-06-08T15:46:59.852467Z","caller":"traceutil/trace.go:172","msg":"trace[554351654] linearizableReadLoop","detail":"{readStateIndex:899; appliedIndex:899; }","duration":"1.355010258s","start":"2026-06-08T15:46:58.497415Z","end":"2026-06-08T15:46:59.852425Z","steps":["trace[554351654] 'read index received' (duration: 1.354984388s)","trace[554351654] 'applied index is now lower than readState.Index' (duration: 24.19µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:46:59.852644Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.355181639s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:59.852686Z","caller":"traceutil/trace.go:172","msg":"trace[357288210] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:865; }","duration":"1.355262449s","start":"2026-06-08T15:46:58.497410Z","end":"2026-06-08T15:46:59.852672Z","steps":["trace[357288210] 'agreement among raft nodes before linearized reading' (duration: 1.355142658s)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:59.852754Z","caller":"traceutil/trace.go:172","msg":"trace[754825556] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"1.54394958s","start":"2026-06-08T15:46:58.308772Z","end":"2026-06-08T15:46:59.852722Z","steps":["trace[754825556] 'process raft request' (duration: 1.543829961s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:59.853300Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:58.308749Z","time spent":"1.54408316s","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:46:59.891826Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"330.099504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:59.891885Z","caller":"traceutil/trace.go:172","msg":"trace[732196473] range","detail":"{range_begin:/registry/serviceaccounts; range_end:; response_count:0; response_revision:866; }","duration":"330.181514ms","start":"2026-06-08T15:46:59.561693Z","end":"2026-06-08T15:46:59.891874Z","steps":["trace[732196473] 'agreement among raft nodes before linearized reading' (duration: 330.054533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:59.891910Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:59.561675Z","time spent":"330.230264ms","remote":"127.0.0.1:48364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:46:59.891949Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"797.495777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:46:59.892019Z","caller":"traceutil/trace.go:172","msg":"trace[1015773353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:866; }","duration":"797.576577ms","start":"2026-06-08T15:46:59.094428Z","end":"2026-06-08T15:46:59.892005Z","steps":["trace[1015773353] 'agreement among raft nodes before linearized reading' (duration: 797.424117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:59.892113Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:59.094409Z","time spent":"797.698047ms","remote":"127.0.0.1:47970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T15:46:59.892167Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.312459738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:46:59.892225Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"446.547523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:46:59.892298Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.3515662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-08T15:46:59.892322Z","caller":"traceutil/trace.go:172","msg":"trace[1321866158] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:869; }","duration":"1.35159114s","start":"2026-06-08T15:46:58.540725Z","end":"2026-06-08T15:46:59.892316Z","steps":["trace[1321866158] 'agreement among raft nodes before linearized reading' (duration: 1.351502761s)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:59.892297Z","caller":"traceutil/trace.go:172","msg":"trace[65341422] range","detail":"{range_begin:/registry/csistoragecapacities; range_end:; response_count:0; response_revision:869; }","duration":"446.632392ms","start":"2026-06-08T15:46:59.445649Z","end":"2026-06-08T15:46:59.892282Z","steps":["trace[65341422] 'agreement among raft nodes before linearized reading' (duration: 446.471883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:59.892337Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:58.540700Z","time spent":"1.35163225s","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:46:59.892359Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:59.445631Z","time spent":"446.714722ms","remote":"127.0.0.1:48852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities\" limit:1 "} {"level":"info","ts":"2026-06-08T15:46:59.892374Z","caller":"traceutil/trace.go:172","msg":"trace[325511468] range","detail":"{range_begin:/registry/jobs; range_end:; response_count:0; response_revision:867; }","duration":"1.312662417s","start":"2026-06-08T15:46:58.579605Z","end":"2026-06-08T15:46:59.892267Z","steps":["trace[325511468] 'agreement among raft nodes before linearized reading' (duration: 1.312362518s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:59.892492Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:58.579587Z","time spent":"1.312888488s","remote":"127.0.0.1:48418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/jobs\" limit:1 "} {"level":"info","ts":"2026-06-08T15:46:59.892548Z","caller":"traceutil/trace.go:172","msg":"trace[733882913] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"244.946362ms","start":"2026-06-08T15:46:59.647592Z","end":"2026-06-08T15:46:59.892538Z","steps":["trace[733882913] 'process raft request' (duration: 244.482692ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:46:59.892510Z","caller":"traceutil/trace.go:172","msg":"trace[1583999731] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"1.103471221s","start":"2026-06-08T15:46:58.789032Z","end":"2026-06-08T15:46:59.892504Z","steps":["trace[1583999731] 'process raft request' (duration: 1.102825111s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:46:59.893027Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:46:58.789008Z","time spent":"1.10395176s","remote":"127.0.0.1:48418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2879,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:46:59.892189Z","caller":"traceutil/trace.go:172","msg":"trace[1829908484] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"243.769842ms","start":"2026-06-08T15:46:59.648404Z","end":"2026-06-08T15:46:59.892174Z","steps":["trace[1829908484] 'process raft request' (duration: 243.708272ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:10.067483Z","caller":"traceutil/trace.go:172","msg":"trace[2057115142] linearizableReadLoop","detail":"{readStateIndex:979; appliedIndex:979; }","duration":"131.238787ms","start":"2026-06-08T15:47:09.936214Z","end":"2026-06-08T15:47:10.067453Z","steps":["trace[2057115142] 'read index received' (duration: 131.228837ms)","trace[2057115142] 'applied index is now lower than readState.Index' (duration: 8.28µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:10.067740Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"131.473027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-08T15:47:10.067726Z","caller":"traceutil/trace.go:172","msg":"trace[1820537821] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"168.053121ms","start":"2026-06-08T15:47:09.899631Z","end":"2026-06-08T15:47:10.067684Z","steps":["trace[1820537821] 'process raft request' (duration: 167.903401ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:10.067784Z","caller":"traceutil/trace.go:172","msg":"trace[436326783] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:943; }","duration":"131.565657ms","start":"2026-06-08T15:47:09.936207Z","end":"2026-06-08T15:47:10.067773Z","steps":["trace[436326783] 'agreement among raft nodes before linearized reading' (duration: 131.352807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:10.238057Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"147.480961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:47:10.238113Z","caller":"traceutil/trace.go:172","msg":"trace[1883031226] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:944; }","duration":"147.547971ms","start":"2026-06-08T15:47:10.090553Z","end":"2026-06-08T15:47:10.238101Z","steps":["trace[1883031226] 'agreement among raft nodes before linearized reading' (duration: 36.391482ms)","trace[1883031226] 'range keys from in-memory index tree' (duration: 111.062289ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:10.238492Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"111.46287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:47:10.238550Z","caller":"traceutil/trace.go:172","msg":"trace[1839004544] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"308.193774ms","start":"2026-06-08T15:47:09.930349Z","end":"2026-06-08T15:47:10.238543Z","steps":["trace[1839004544] 'process raft request' (duration: 196.636924ms)","trace[1839004544] 'compare' (duration: 111.40555ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:10.238576Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:09.930321Z","time spent":"308.241724ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:47:10.238793Z","caller":"traceutil/trace.go:172","msg":"trace[1312898819] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"308.322915ms","start":"2026-06-08T15:47:09.930447Z","end":"2026-06-08T15:47:10.238770Z","steps":["trace[1312898819] 'process raft request' (duration: 308.077404ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:10.238798Z","caller":"traceutil/trace.go:172","msg":"trace[1234433171] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:980; }","duration":"111.854281ms","start":"2026-06-08T15:47:10.126924Z","end":"2026-06-08T15:47:10.238778Z","steps":["trace[1234433171] 'read index received' (duration: 90.98511ms)","trace[1234433171] 'applied index is now lower than readState.Index' (duration: 20.867411ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:47:10.238818Z","caller":"traceutil/trace.go:172","msg":"trace[1297096349] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"116.2992ms","start":"2026-06-08T15:47:10.122511Z","end":"2026-06-08T15:47:10.238810Z","steps":["trace[1297096349] 'process raft request' (duration: 116.26336ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:10.238867Z","caller":"traceutil/trace.go:172","msg":"trace[42865723] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"166.81226ms","start":"2026-06-08T15:47:10.072016Z","end":"2026-06-08T15:47:10.238828Z","steps":["trace[42865723] 'process raft request' (duration: 166.727049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:10.239055Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:09.930408Z","time spent":"308.443235ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:47:10.239186Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"129.557006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-08T15:47:10.239282Z","caller":"traceutil/trace.go:172","msg":"trace[1866054913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:948; }","duration":"129.654036ms","start":"2026-06-08T15:47:10.109611Z","end":"2026-06-08T15:47:10.239265Z","steps":["trace[1866054913] 'agreement among raft nodes before linearized reading' (duration: 129.219045ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:16.472268Z","caller":"traceutil/trace.go:172","msg":"trace[13546403] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1003; }","duration":"187.079475ms","start":"2026-06-08T15:47:16.285166Z","end":"2026-06-08T15:47:16.472246Z","steps":["trace[13546403] 'read index received' (duration: 187.073865ms)","trace[13546403] 'applied index is now lower than readState.Index' (duration: 4.88µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:16.586183Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"300.998101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:47:16.586257Z","caller":"traceutil/trace.go:172","msg":"trace[2095377972] range","detail":"{range_begin:/registry/configmaps; range_end:; response_count:0; response_revision:966; }","duration":"301.075551ms","start":"2026-06-08T15:47:16.285160Z","end":"2026-06-08T15:47:16.586236Z","steps":["trace[2095377972] 'agreement among raft nodes before linearized reading' (duration: 187.174525ms)","trace[2095377972] 'range keys from in-memory index tree' (duration: 113.798766ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:16.586286Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:16.285143Z","time spent":"301.136442ms","remote":"127.0.0.1:48160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:47:16.586368Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"114.063597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:47:16.586596Z","caller":"traceutil/trace.go:172","msg":"trace[71715848] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"330.681405ms","start":"2026-06-08T15:47:16.255903Z","end":"2026-06-08T15:47:16.586584Z","steps":["trace[71715848] 'process raft request' (duration: 216.327827ms)","trace[71715848] 'compare' (duration: 113.855506ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:47:16.586645Z","caller":"traceutil/trace.go:172","msg":"trace[146572013] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"327.785456ms","start":"2026-06-08T15:47:16.258847Z","end":"2026-06-08T15:47:16.586632Z","steps":["trace[146572013] 'process raft request' (duration: 327.713126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:16.586666Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:16.255883Z","time spent":"330.738995ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:47:16.586703Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:16.258836Z","time spent":"327.843476ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:47:16.586761Z","caller":"traceutil/trace.go:172","msg":"trace[2039281902] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"328.163516ms","start":"2026-06-08T15:47:16.258588Z","end":"2026-06-08T15:47:16.586751Z","steps":["trace[2039281902] 'process raft request' (duration: 327.869845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:16.586815Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:16.258578Z","time spent":"328.213706ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:47:16.657154Z","caller":"traceutil/trace.go:172","msg":"trace[1973524333] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1006; }","duration":"184.785748ms","start":"2026-06-08T15:47:16.472348Z","end":"2026-06-08T15:47:16.657134Z","steps":["trace[1973524333] 'read index received' (duration: 184.777758ms)","trace[1973524333] 'applied index is now lower than readState.Index' (duration: 6.79µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:47:16.657290Z","caller":"traceutil/trace.go:172","msg":"trace[741269804] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"373.446248ms","start":"2026-06-08T15:47:16.283835Z","end":"2026-06-08T15:47:16.657282Z","steps":["trace[741269804] 'process raft request' (duration: 373.366457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:16.657371Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:16.283809Z","time spent":"373.512349ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":478,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:47:16.658741Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"350.989809ms","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-06-08T15:47:16.658815Z","caller":"traceutil/trace.go:172","msg":"trace[360041485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:969; }","duration":"351.064799ms","start":"2026-06-08T15:47:16.307733Z","end":"2026-06-08T15:47:16.658798Z","steps":["trace[360041485] 'agreement among raft nodes before linearized reading' (duration: 349.477523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:16.658865Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:16.307678Z","time spent":"351.173319ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:47:16.910438Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"324.338325ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:47:16.910547Z","caller":"traceutil/trace.go:172","msg":"trace[221463641] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:970; }","duration":"324.461025ms","start":"2026-06-08T15:47:16.586059Z","end":"2026-06-08T15:47:16.910520Z","steps":["trace[221463641] 'agreement among raft nodes before linearized reading' (duration: 157.036351ms)","trace[221463641] 'range keys from in-memory index tree' (duration: 167.267183ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:16.984990Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"241.837047ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-08T15:47:16.985365Z","caller":"traceutil/trace.go:172","msg":"trace[601104651] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1007; }","duration":"171.007085ms","start":"2026-06-08T15:47:16.814333Z","end":"2026-06-08T15:47:16.985340Z","steps":["trace[601104651] 'read index received' (duration: 40.440507ms)","trace[601104651] 'applied index is now lower than readState.Index' (duration: 130.564228ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:16.985749Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"171.393137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-86c8f9f5d8-sv85f\" limit:1 ","response":"range_response_count:1 size:6358"} {"level":"info","ts":"2026-06-08T15:47:16.985826Z","caller":"traceutil/trace.go:172","msg":"trace[634244574] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-86c8f9f5d8-sv85f; range_end:; response_count:1; response_revision:970; }","duration":"171.475147ms","start":"2026-06-08T15:47:16.814329Z","end":"2026-06-08T15:47:16.985804Z","steps":["trace[634244574] 'agreement among raft nodes before linearized reading' (duration: 171.248216ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:16.985844Z","caller":"traceutil/trace.go:172","msg":"trace[1875166456] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"323.840464ms","start":"2026-06-08T15:47:16.661990Z","end":"2026-06-08T15:47:16.985830Z","steps":["trace[1875166456] 'process raft request' (duration: 323.110932ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:16.986084Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:16.661971Z","time spent":"324.060094ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:47:17.444122Z","caller":"traceutil/trace.go:172","msg":"trace[143196859] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"447.782331ms","start":"2026-06-08T15:47:16.996329Z","end":"2026-06-08T15:47:17.444111Z","steps":["trace[143196859] 'process raft request' (duration: 447.173908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:17.444213Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:16.996303Z","time spent":"447.863321ms","remote":"127.0.0.1:48326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6153,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:47:18.001335Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1640610608278495906,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T15:47:18.216622Z","caller":"traceutil/trace.go:172","msg":"trace[532648665] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1011; }","duration":"715.587006ms","start":"2026-06-08T15:47:17.501012Z","end":"2026-06-08T15:47:18.216599Z","steps":["trace[532648665] 'read index received' (duration: 715.579036ms)","trace[532648665] 'applied index is now lower than readState.Index' (duration: 6.97µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:18.285015Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"784.005765ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:47:18.285117Z","caller":"traceutil/trace.go:172","msg":"trace[1401901860] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:973; }","duration":"784.111625ms","start":"2026-06-08T15:47:17.500980Z","end":"2026-06-08T15:47:18.285091Z","steps":["trace[1401901860] 'agreement among raft nodes before linearized reading' (duration: 715.720897ms)","trace[1401901860] 'range keys from in-memory index tree' (duration: 68.261198ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:18.285160Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"307.219348ms","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-06-08T15:47:18.285208Z","caller":"traceutil/trace.go:172","msg":"trace[1834124580] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:973; }","duration":"307.259108ms","start":"2026-06-08T15:47:17.977928Z","end":"2026-06-08T15:47:18.285187Z","steps":["trace[1834124580] 'range keys from in-memory index tree' (duration: 307.187088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:18.285431Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"193.462984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:47:18.285480Z","caller":"traceutil/trace.go:172","msg":"trace[393458712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:975; }","duration":"193.510734ms","start":"2026-06-08T15:47:18.091959Z","end":"2026-06-08T15:47:18.285470Z","steps":["trace[393458712] 'agreement among raft nodes before linearized reading' (duration: 193.438814ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:18.285540Z","caller":"traceutil/trace.go:172","msg":"trace[1027035813] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"832.885146ms","start":"2026-06-08T15:47:17.452634Z","end":"2026-06-08T15:47:18.285519Z","steps":["trace[1027035813] 'process raft request' (duration: 764.017746ms)","trace[1027035813] 'compare' (duration: 68.62565ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:47:18.285654Z","caller":"traceutil/trace.go:172","msg":"trace[384719382] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"832.745098ms","start":"2026-06-08T15:47:17.452897Z","end":"2026-06-08T15:47:18.285642Z","steps":["trace[384719382] 'process raft request' (duration: 832.458536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:18.285683Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:17.452621Z","time spent":"832.987968ms","remote":"127.0.0.1:48294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:47:18.285705Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:17.452882Z","time spent":"832.794958ms","remote":"127.0.0.1:48972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:47:18.285817Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"136.394976ms","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-06-08T15:47:18.285893Z","caller":"traceutil/trace.go:172","msg":"trace[246526001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:975; }","duration":"136.479526ms","start":"2026-06-08T15:47:18.149399Z","end":"2026-06-08T15:47:18.285879Z","steps":["trace[246526001] 'agreement among raft nodes before linearized reading' (duration: 136.297426ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:32.803355Z","caller":"traceutil/trace.go:172","msg":"trace[382686442] linearizableReadLoop","detail":"{readStateIndex:1069; appliedIndex:1069; }","duration":"105.776155ms","start":"2026-06-08T15:47:32.697551Z","end":"2026-06-08T15:47:32.803327Z","steps":["trace[382686442] 'read index received' (duration: 105.766385ms)","trace[382686442] 'applied index is now lower than readState.Index' (duration: 7.91µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:32.803477Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"105.925655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceclaims\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:47:32.803513Z","caller":"traceutil/trace.go:172","msg":"trace[1019645823] range","detail":"{range_begin:/registry/resourceclaims; range_end:; response_count:0; response_revision:1028; }","duration":"105.973626ms","start":"2026-06-08T15:47:32.697531Z","end":"2026-06-08T15:47:32.803505Z","steps":["trace[1019645823] 'agreement among raft nodes before linearized reading' (duration: 105.891925ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:32.803823Z","caller":"traceutil/trace.go:172","msg":"trace[2042456755] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"156.848407ms","start":"2026-06-08T15:47:32.646923Z","end":"2026-06-08T15:47:32.803771Z","steps":["trace[2042456755] 'process raft request' (duration: 156.562406ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:32.824993Z","caller":"traceutil/trace.go:172","msg":"trace[1286400144] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"178.021569ms","start":"2026-06-08T15:47:32.646952Z","end":"2026-06-08T15:47:32.824974Z","steps":["trace[1286400144] 'process raft request' (duration: 177.934438ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:33.283225Z","caller":"traceutil/trace.go:172","msg":"trace[1854989210] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"159.839557ms","start":"2026-06-08T15:47:33.123370Z","end":"2026-06-08T15:47:33.283209Z","steps":["trace[1854989210] 'process raft request' (duration: 159.722556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:33.507382Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"142.659505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:47:33.507549Z","caller":"traceutil/trace.go:172","msg":"trace[1650093429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1032; }","duration":"142.828756ms","start":"2026-06-08T15:47:33.364690Z","end":"2026-06-08T15:47:33.507518Z","steps":["trace[1650093429] 'range keys from in-memory index tree' (duration: 142.549385ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:43.152095Z","caller":"traceutil/trace.go:172","msg":"trace[1933599096] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1103; }","duration":"184.766838ms","start":"2026-06-08T15:47:42.967307Z","end":"2026-06-08T15:47:43.152074Z","steps":["trace[1933599096] 'read index received' (duration: 184.758998ms)","trace[1933599096] 'applied index is now lower than readState.Index' (duration: 6.78µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:47:43.152294Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"184.964019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-08T15:47:43.152321Z","caller":"traceutil/trace.go:172","msg":"trace[986381503] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1060; }","duration":"185.012689ms","start":"2026-06-08T15:47:42.967302Z","end":"2026-06-08T15:47:43.152315Z","steps":["trace[986381503] 'agreement among raft nodes before linearized reading' (duration: 184.876338ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:43.152343Z","caller":"traceutil/trace.go:172","msg":"trace[2020412596] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"391.656343ms","start":"2026-06-08T15:47:42.760667Z","end":"2026-06-08T15:47:43.152323Z","steps":["trace[2020412596] 'process raft request' (duration: 391.447292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:43.152520Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:47:42.760650Z","time spent":"391.779414ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:47:43.153219Z","caller":"traceutil/trace.go:172","msg":"trace[706148079] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"265.285344ms","start":"2026-06-08T15:47:42.887917Z","end":"2026-06-08T15:47:43.153202Z","steps":["trace[706148079] 'process raft request' (duration: 265.247184ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:43.153359Z","caller":"traceutil/trace.go:172","msg":"trace[1714005170] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"291.263057ms","start":"2026-06-08T15:47:42.862065Z","end":"2026-06-08T15:47:43.153328Z","steps":["trace[1714005170] 'process raft request' (duration: 291.028225ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:43.572054Z","caller":"traceutil/trace.go:172","msg":"trace[1329829852] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"190.879266ms","start":"2026-06-08T15:47:43.381148Z","end":"2026-06-08T15:47:43.572028Z","steps":["trace[1329829852] 'process raft request' (duration: 190.364772ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:47:55.378484Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"149.213123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-08T15:47:55.378554Z","caller":"traceutil/trace.go:172","msg":"trace[367116424] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1100; }","duration":"149.295694ms","start":"2026-06-08T15:47:55.229243Z","end":"2026-06-08T15:47:55.378538Z","steps":["trace[367116424] 'agreement among raft nodes before linearized reading' (duration: 103.234735ms)","trace[367116424] 'range keys from in-memory index tree' (duration: 45.872558ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:47:55.378716Z","caller":"traceutil/trace.go:172","msg":"trace[36478433] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"148.7837ms","start":"2026-06-08T15:47:55.229916Z","end":"2026-06-08T15:47:55.378700Z","steps":["trace[36478433] 'process raft request' (duration: 148.740769ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:47:55.378814Z","caller":"traceutil/trace.go:172","msg":"trace[110918626] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"148.993912ms","start":"2026-06-08T15:47:55.229807Z","end":"2026-06-08T15:47:55.378801Z","steps":["trace[110918626] 'process raft request' (duration: 102.629599ms)","trace[110918626] 'compare' (duration: 46.07911ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:48:12.869565Z","caller":"traceutil/trace.go:172","msg":"trace[454277923] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"149.079092ms","start":"2026-06-08T15:48:12.720468Z","end":"2026-06-08T15:48:12.869547Z","steps":["trace[454277923] 'process raft request' (duration: 148.91528ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:17.608504Z","caller":"traceutil/trace.go:172","msg":"trace[1148106919] linearizableReadLoop","detail":"{readStateIndex:1224; appliedIndex:1224; }","duration":"108.415807ms","start":"2026-06-08T15:48:17.499184Z","end":"2026-06-08T15:48:17.607600Z","steps":["trace[1148106919] 'read index received' (duration: 108.392886ms)","trace[1148106919] 'applied index is now lower than readState.Index' (duration: 20.361µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:17.609841Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"112.334397ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:48:17.609890Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.670601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-08T15:48:17.609983Z","caller":"traceutil/trace.go:172","msg":"trace[1247619624] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1174; }","duration":"110.796922ms","start":"2026-06-08T15:48:17.499163Z","end":"2026-06-08T15:48:17.609960Z","steps":["trace[1247619624] 'agreement among raft nodes before linearized reading' (duration: 108.60667ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:17.610183Z","caller":"traceutil/trace.go:172","msg":"trace[306993145] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"120.670953ms","start":"2026-06-08T15:48:17.489493Z","end":"2026-06-08T15:48:17.610164Z","steps":["trace[306993145] 'process raft request' (duration: 118.186587ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:17.609943Z","caller":"traceutil/trace.go:172","msg":"trace[301259913] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1174; }","duration":"112.472429ms","start":"2026-06-08T15:48:17.497452Z","end":"2026-06-08T15:48:17.609925Z","steps":["trace[301259913] 'range keys from in-memory index tree' (duration: 112.274627ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:17.613585Z","caller":"traceutil/trace.go:172","msg":"trace[872400222] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"122.431812ms","start":"2026-06-08T15:48:17.491124Z","end":"2026-06-08T15:48:17.613556Z","steps":["trace[872400222] 'process raft request' (duration: 121.986687ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:21.709784Z","caller":"traceutil/trace.go:172","msg":"trace[996444942] linearizableReadLoop","detail":"{readStateIndex:1237; appliedIndex:1237; }","duration":"224.637647ms","start":"2026-06-08T15:48:21.485117Z","end":"2026-06-08T15:48:21.709755Z","steps":["trace[996444942] 'read index received' (duration: 224.624777ms)","trace[996444942] 'applied index is now lower than readState.Index' (duration: 10.89µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:21.710027Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"224.897759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" limit:1 ","response":"range_response_count:1 size:1102"} {"level":"info","ts":"2026-06-08T15:48:21.710040Z","caller":"traceutil/trace.go:172","msg":"trace[1779643437] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"227.148274ms","start":"2026-06-08T15:48:21.482871Z","end":"2026-06-08T15:48:21.710019Z","steps":["trace[1779643437] 'process raft request' (duration: 226.986672ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:21.710104Z","caller":"traceutil/trace.go:172","msg":"trace[1018956490] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:1; response_revision:1186; }","duration":"224.99258ms","start":"2026-06-08T15:48:21.485099Z","end":"2026-06-08T15:48:21.710091Z","steps":["trace[1018956490] 'agreement among raft nodes before linearized reading' (duration: 224.770728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:21.715090Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"217.37484ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:48:21.715139Z","caller":"traceutil/trace.go:172","msg":"trace[1569204573] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1187; }","duration":"217.432401ms","start":"2026-06-08T15:48:21.497697Z","end":"2026-06-08T15:48:21.715130Z","steps":["trace[1569204573] 'agreement among raft nodes before linearized reading' (duration: 217.34643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:21.715448Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"200.924266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:attachdetach-controller\" limit:1 ","response":"range_response_count:1 size:952"} {"level":"info","ts":"2026-06-08T15:48:21.715927Z","caller":"traceutil/trace.go:172","msg":"trace[1281003938] range","detail":"{range_begin:/registry/clusterroles/system:controller:attachdetach-controller; range_end:; response_count:1; response_revision:1188; }","duration":"201.413622ms","start":"2026-06-08T15:48:21.514497Z","end":"2026-06-08T15:48:21.715911Z","steps":["trace[1281003938] 'agreement among raft nodes before linearized reading' (duration: 200.749645ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:25.964251Z","caller":"traceutil/trace.go:172","msg":"trace[1660524918] linearizableReadLoop","detail":"{readStateIndex:1250; appliedIndex:1250; }","duration":"229.129083ms","start":"2026-06-08T15:48:25.735088Z","end":"2026-06-08T15:48:25.964218Z","steps":["trace[1660524918] 'read index received' (duration: 229.093383ms)","trace[1660524918] 'applied index is now lower than readState.Index' (duration: 31.97µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:26.174262Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"440.316302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:replication-controller\" limit:1 ","response":"range_response_count:1 size:830"} {"level":"info","ts":"2026-06-08T15:48:26.174629Z","caller":"traceutil/trace.go:172","msg":"trace[964633681] range","detail":"{range_begin:/registry/clusterroles/system:controller:replication-controller; range_end:; response_count:1; response_revision:1199; }","duration":"440.692305ms","start":"2026-06-08T15:48:25.733909Z","end":"2026-06-08T15:48:26.174601Z","steps":["trace[964633681] 'agreement among raft nodes before linearized reading' (duration: 230.452217ms)","trace[964633681] 'range keys from in-memory index tree' (duration: 209.725784ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:26.174687Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:48:25.733899Z","time spent":"440.771167ms","remote":"127.0.0.1:48660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":853,"request content":"key:\"/registry/clusterroles/system:controller:replication-controller\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:48:26.174737Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"210.37372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T15:48:26.174965Z","caller":"traceutil/trace.go:172","msg":"trace[502172706] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"436.260158ms","start":"2026-06-08T15:48:25.738693Z","end":"2026-06-08T15:48:26.174953Z","steps":["trace[502172706] 'process raft request' (duration: 436.204807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:26.175018Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:48:25.738673Z","time spent":"436.319938ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":479,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:48:26.175020Z","caller":"traceutil/trace.go:172","msg":"trace[28675111] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"445.219544ms","start":"2026-06-08T15:48:25.729786Z","end":"2026-06-08T15:48:26.175006Z","steps":["trace[28675111] 'process raft request' (duration: 234.502931ms)","trace[28675111] 'compare' (duration: 209.750803ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:26.175103Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:48:25.729766Z","time spent":"445.284965ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T15:48:26.175191Z","caller":"traceutil/trace.go:172","msg":"trace[1529533748] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"445.392216ms","start":"2026-06-08T15:48:25.729786Z","end":"2026-06-08T15:48:26.175179Z","steps":["trace[1529533748] 'process raft request' (duration: 445.048822ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:26.175221Z","caller":"traceutil/trace.go:172","msg":"trace[226515128] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1250; }","duration":"210.870525ms","start":"2026-06-08T15:48:25.964343Z","end":"2026-06-08T15:48:26.175213Z","steps":["trace[226515128] 'read index received' (duration: 210.259188ms)","trace[226515128] 'applied index is now lower than readState.Index' (duration: 610.687µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:26.175252Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:48:25.729769Z","time spent":"445.451997ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:48:26.175292Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"383.726838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:namespace-controller\" limit:1 ","response":"range_response_count:1 size:755"} {"level":"info","ts":"2026-06-08T15:48:26.175312Z","caller":"traceutil/trace.go:172","msg":"trace[1999209796] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:namespace-controller; range_end:; response_count:1; response_revision:1202; }","duration":"383.750608ms","start":"2026-06-08T15:48:25.791555Z","end":"2026-06-08T15:48:26.175306Z","steps":["trace[1999209796] 'agreement among raft nodes before linearized reading' (duration: 383.683507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:26.175327Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:48:25.791532Z","time spent":"383.790449ms","remote":"127.0.0.1:48674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":778,"request content":"key:\"/registry/clusterrolebindings/system:controller:namespace-controller\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:48:26.175441Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"373.058502ms","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-06-08T15:48:26.175487Z","caller":"traceutil/trace.go:172","msg":"trace[1113714081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1202; }","duration":"373.107172ms","start":"2026-06-08T15:48:25.802366Z","end":"2026-06-08T15:48:26.175473Z","steps":["trace[1113714081] 'agreement among raft nodes before linearized reading' (duration: 372.961821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:26.175522Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:48:25.802331Z","time spent":"373.181454ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-06-08T15:48:26.849375Z","caller":"traceutil/trace.go:172","msg":"trace[1435464575] linearizableReadLoop","detail":"{readStateIndex:1255; appliedIndex:1255; }","duration":"144.665215ms","start":"2026-06-08T15:48:26.704685Z","end":"2026-06-08T15:48:26.849351Z","steps":["trace[1435464575] 'read index received' (duration: 144.657245ms)","trace[1435464575] 'applied index is now lower than readState.Index' (duration: 6.83µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:26.849678Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"144.964979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:resourcequota-controller\" limit:1 ","response":"range_response_count:1 size:700"} {"level":"info","ts":"2026-06-08T15:48:26.849752Z","caller":"traceutil/trace.go:172","msg":"trace[2117173286] range","detail":"{range_begin:/registry/clusterroles/system:controller:resourcequota-controller; range_end:; response_count:1; response_revision:1204; }","duration":"145.05785ms","start":"2026-06-08T15:48:26.704681Z","end":"2026-06-08T15:48:26.849739Z","steps":["trace[2117173286] 'agreement among raft nodes before linearized reading' (duration: 144.783096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:26.976369Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"126.893733ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-08T15:48:26.976701Z","caller":"traceutil/trace.go:172","msg":"trace[546151192] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1255; }","duration":"127.234556ms","start":"2026-06-08T15:48:26.849444Z","end":"2026-06-08T15:48:26.976678Z","steps":["trace[546151192] 'read index received' (duration: 20.5µs)","trace[546151192] 'applied index is now lower than readState.Index' (duration: 127.212116ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:26.977018Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"242.964027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:persistent-volume-binder\" limit:1 ","response":"range_response_count:1 size:771"} {"level":"warn","ts":"2026-06-08T15:48:26.977034Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"123.791589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:resourcequota-controller\" limit:1 ","response":"range_response_count:1 size:700"} {"level":"info","ts":"2026-06-08T15:48:26.977096Z","caller":"traceutil/trace.go:172","msg":"trace[480738156] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:1204; }","duration":"243.077768ms","start":"2026-06-08T15:48:26.734006Z","end":"2026-06-08T15:48:26.977083Z","steps":["trace[480738156] 'agreement among raft nodes before linearized reading' (duration: 242.832065ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:26.977270Z","caller":"traceutil/trace.go:172","msg":"trace[480498714] range","detail":"{range_begin:/registry/clusterroles/system:controller:resourcequota-controller; range_end:; response_count:1; response_revision:1204; }","duration":"124.016051ms","start":"2026-06-08T15:48:26.853224Z","end":"2026-06-08T15:48:26.977240Z","steps":["trace[480498714] 'agreement among raft nodes before linearized reading' (duration: 123.689688ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:27.160849Z","caller":"traceutil/trace.go:172","msg":"trace[280435337] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"177.933728ms","start":"2026-06-08T15:48:26.982900Z","end":"2026-06-08T15:48:27.160833Z","steps":["trace[280435337] 'process raft request' (duration: 177.831247ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:43.453266Z","caller":"traceutil/trace.go:172","msg":"trace[1635264937] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"193.810377ms","start":"2026-06-08T15:48:43.259433Z","end":"2026-06-08T15:48:43.453243Z","steps":["trace[1635264937] 'process raft request' (duration: 193.653826ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:43.453449Z","caller":"traceutil/trace.go:172","msg":"trace[1935435495] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1313; }","duration":"193.285852ms","start":"2026-06-08T15:48:43.260150Z","end":"2026-06-08T15:48:43.453436Z","steps":["trace[1935435495] 'read index received' (duration: 193.279162ms)","trace[1935435495] 'applied index is now lower than readState.Index' (duration: 5.65µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:43.453708Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"177.734868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" limit:1 ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-06-08T15:48:43.453799Z","caller":"traceutil/trace.go:172","msg":"trace[1448897278] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:1258; }","duration":"177.841619ms","start":"2026-06-08T15:48:43.275942Z","end":"2026-06-08T15:48:43.453784Z","steps":["trace[1448897278] 'agreement among raft nodes before linearized reading' (duration: 177.613387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:43.453942Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"193.778287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:79 size:59445"} {"level":"info","ts":"2026-06-08T15:48:43.453985Z","caller":"traceutil/trace.go:172","msg":"trace[386053347] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:79; response_revision:1258; }","duration":"193.835068ms","start":"2026-06-08T15:48:43.260140Z","end":"2026-06-08T15:48:43.453975Z","steps":["trace[386053347] 'agreement among raft nodes before linearized reading' (duration: 193.375803ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:44.069312Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"245.663542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-06-08T15:48:44.069340Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"172.288936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-08T15:48:44.069389Z","caller":"traceutil/trace.go:172","msg":"trace[619607563] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:1; response_revision:1259; }","duration":"245.752073ms","start":"2026-06-08T15:48:43.823625Z","end":"2026-06-08T15:48:44.069377Z","steps":["trace[619607563] 'range keys from in-memory index tree' (duration: 245.470949ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:44.069413Z","caller":"traceutil/trace.go:172","msg":"trace[463258640] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:1; response_revision:1259; }","duration":"172.371317ms","start":"2026-06-08T15:48:43.897022Z","end":"2026-06-08T15:48:44.069394Z","steps":["trace[463258640] 'range keys from in-memory index tree' (duration: 172.097914ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:44.545985Z","caller":"traceutil/trace.go:172","msg":"trace[1356939306] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1317; }","duration":"144.700915ms","start":"2026-06-08T15:48:44.401254Z","end":"2026-06-08T15:48:44.545955Z","steps":["trace[1356939306] 'read index received' (duration: 144.689065ms)","trace[1356939306] 'applied index is now lower than readState.Index' (duration: 10.13µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:44.573870Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"199.053598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pvc-protection-controller\" limit:1 ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-06-08T15:48:44.574582Z","caller":"traceutil/trace.go:172","msg":"trace[1621078516] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pvc-protection-controller; range_end:; response_count:1; response_revision:1262; }","duration":"199.745197ms","start":"2026-06-08T15:48:44.374788Z","end":"2026-06-08T15:48:44.574533Z","steps":["trace[1621078516] 'agreement among raft nodes before linearized reading' (duration: 171.301399ms)","trace[1621078516] 'range keys from in-memory index tree' (duration: 27.655368ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:44.574170Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"169.413077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:48:44.574803Z","caller":"traceutil/trace.go:172","msg":"trace[1730616217] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:1263; }","duration":"170.062185ms","start":"2026-06-08T15:48:44.404724Z","end":"2026-06-08T15:48:44.574786Z","steps":["trace[1730616217] 'agreement among raft nodes before linearized reading' (duration: 169.383427ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:44.574444Z","caller":"traceutil/trace.go:172","msg":"trace[436435887] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"221.070129ms","start":"2026-06-08T15:48:44.353356Z","end":"2026-06-08T15:48:44.574426Z","steps":["trace[436435887] 'process raft request' (duration: 192.688753ms)","trace[436435887] 'compare' (duration: 27.89155ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:48:45.654344Z","caller":"traceutil/trace.go:172","msg":"trace[1645890838] linearizableReadLoop","detail":"{readStateIndex:1318; appliedIndex:1318; }","duration":"190.302733ms","start":"2026-06-08T15:48:45.464001Z","end":"2026-06-08T15:48:45.654304Z","steps":["trace[1645890838] 'read index received' (duration: 190.284873ms)","trace[1645890838] 'applied index is now lower than readState.Index' (duration: 15.53µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:48:45.654512Z","caller":"traceutil/trace.go:172","msg":"trace[1072758042] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"193.961237ms","start":"2026-06-08T15:48:45.460530Z","end":"2026-06-08T15:48:45.654492Z","steps":["trace[1072758042] 'process raft request' (duration: 193.827985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:45.654599Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"156.617243ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:48:45.654678Z","caller":"traceutil/trace.go:172","msg":"trace[232967049] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1264; }","duration":"156.704354ms","start":"2026-06-08T15:48:45.497947Z","end":"2026-06-08T15:48:45.654652Z","steps":["trace[232967049] 'agreement among raft nodes before linearized reading' (duration: 156.570653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:45.654718Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"190.701739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-08T15:48:45.654754Z","caller":"traceutil/trace.go:172","msg":"trace[1933968760] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-cidrs-controller; range_end:; response_count:1; response_revision:1264; }","duration":"190.752879ms","start":"2026-06-08T15:48:45.463992Z","end":"2026-06-08T15:48:45.654744Z","steps":["trace[1933968760] 'agreement among raft nodes before linearized reading' (duration: 190.421225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:45.654860Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"138.593569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-08T15:48:45.654982Z","caller":"traceutil/trace.go:172","msg":"trace[44969226] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:1; response_revision:1264; }","duration":"138.74084ms","start":"2026-06-08T15:48:45.516201Z","end":"2026-06-08T15:48:45.654942Z","steps":["trace[44969226] 'agreement among raft nodes before linearized reading' (duration: 138.364516ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:46.812886Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"114.127603ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-08T15:48:46.813475Z","caller":"traceutil/trace.go:172","msg":"trace[915109590] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"190.10736ms","start":"2026-06-08T15:48:46.623350Z","end":"2026-06-08T15:48:46.813457Z","steps":["trace[915109590] 'process raft request' (duration: 189.939228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:47.875810Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"135.466382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:48:47.875937Z","caller":"traceutil/trace.go:172","msg":"trace[1850695694] range","detail":"{range_begin:/registry/replicasets; range_end:; response_count:0; response_revision:1271; }","duration":"135.623595ms","start":"2026-06-08T15:48:47.740290Z","end":"2026-06-08T15:48:47.875914Z","steps":["trace[1850695694] 'range keys from in-memory index tree' (duration: 135.2411ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:48.387252Z","caller":"traceutil/trace.go:172","msg":"trace[593816297] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"119.371146ms","start":"2026-06-08T15:48:48.267852Z","end":"2026-06-08T15:48:48.387224Z","steps":["trace[593816297] 'process raft request' (duration: 119.218565ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:48.748384Z","caller":"traceutil/trace.go:172","msg":"trace[1992249651] linearizableReadLoop","detail":"{readStateIndex:1330; appliedIndex:1330; }","duration":"274.550891ms","start":"2026-06-08T15:48:48.473803Z","end":"2026-06-08T15:48:48.748354Z","steps":["trace[1992249651] 'read index received' (duration: 274.529261ms)","trace[1992249651] 'applied index is now lower than readState.Index' (duration: 19.33µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:48.826574Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"352.752782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T15:48:48.826603Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"328.214167ms","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-06-08T15:48:48.826649Z","caller":"traceutil/trace.go:172","msg":"trace[44696768] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:1274; }","duration":"352.834823ms","start":"2026-06-08T15:48:48.473797Z","end":"2026-06-08T15:48:48.826632Z","steps":["trace[44696768] 'agreement among raft nodes before linearized reading' (duration: 274.647212ms)","trace[44696768] 'range keys from in-memory index tree' (duration: 78.078139ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T15:48:48.826662Z","caller":"traceutil/trace.go:172","msg":"trace[505135005] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1274; }","duration":"328.278558ms","start":"2026-06-08T15:48:48.498367Z","end":"2026-06-08T15:48:48.826646Z","steps":["trace[505135005] 'range keys from in-memory index tree' (duration: 328.156827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:48.826683Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:48:48.473778Z","time spent":"352.896753ms","remote":"127.0.0.1:48326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/pods\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:48:48.826746Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"337.550459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-08T15:48:48.826787Z","caller":"traceutil/trace.go:172","msg":"trace[983904295] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1275; }","duration":"337.594009ms","start":"2026-06-08T15:48:48.489184Z","end":"2026-06-08T15:48:48.826778Z","steps":["trace[983904295] 'agreement among raft nodes before linearized reading' (duration: 337.463008ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T15:48:48.826760Z","caller":"traceutil/trace.go:172","msg":"trace[1291891154] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"405.603929ms","start":"2026-06-08T15:48:48.421125Z","end":"2026-06-08T15:48:48.826729Z","steps":["trace[1291891154] 'process raft request' (duration: 327.230426ms)","trace[1291891154] 'compare' (duration: 78.126889ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T15:48:48.826813Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:48:48.489142Z","time spent":"337.662791ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-06-08T15:48:48.826880Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-06-08T15:48:48.421101Z","time spent":"405.71442ms","remote":"127.0.0.1:48452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T15:48:48.827027Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"149.66379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T15:48:48.827059Z","caller":"traceutil/trace.go:172","msg":"trace[1954071640] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies; range_end:; response_count:0; response_revision:1275; }","duration":"149.69851ms","start":"2026-06-08T15:48:48.677352Z","end":"2026-06-08T15:48:48.827051Z","steps":["trace[1954071640] 'agreement among raft nodes before linearized reading' (duration: 149.608629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T15:48:48.827136Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"149.437426ms","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-06-08T15:48:48.827172Z","caller":"traceutil/trace.go:172","msg":"trace[2082871119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1275; }","duration":"149.473516ms","start":"2026-06-08T15:48:48.677688Z","end":"2026-06-08T15:48:48.827162Z","steps":["trace[2082871119] 'agreement among raft nodes before linearized reading' (duration: 149.288794ms)"],"step_count":1}