{"level":"warn","ts":"2026-05-20T21:24:26.309624Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-05-20T21:24:26.309737Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-05-20T21:24:26.309748Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.103: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.103:2380","--initial-cluster=controller=https://199.19.213.103:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.103:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.103:2380","--name=controller","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-05-20T21:24:26.429825Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-05-20T21:24:26.429915Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T21:24:26.429964Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.103:2380"]} {"level":"info","ts":"2026-05-20T21:24:26.430191Z","caller":"embed/etcd.go:544","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T21:24:26.431570Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.103:2379"]} {"level":"info","ts":"2026-05-20T21:24:26.431807Z","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.103:2380"],"listen-peer-urls":["https://199.19.213.103:2380"],"advertise-client-urls":["https://199.19.213.103:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.103:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.19.213.103:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"feature-gates":"InitialCorruptCheck=true","initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","discovery-token":"","discovery-endpoints":"","discovery-dial-timeout":"2s","discovery-request-timeout":"5s","discovery-keepalive-time":"2s","discovery-keepalive-timeout":"6s","discovery-insecure-transport":true,"discovery-insecure-skip-tls-verify":false,"discovery-cert":"","discovery-key":"","discovery-cacert":"","discovery-user":"","downgrade-check-interval":"5s","max-learners":1,"v2-deprecation":"write-only"} {"level":"info","ts":"2026-05-20T21:24:26.433650Z","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: 0xc000136540}"} {"level":"info","ts":"2026-05-20T21:24:26.601515Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-05-20T21:24:26.601664Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"168.17822ms"} {"level":"info","ts":"2026-05-20T21:24:26.601708Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-05-20T21:24:26.601725Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-05-20T21:24:26.601794Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-05-20T21:24:27.066446Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-05-20T21:24:27.066692Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"d82047944f922143","cluster-id":"223a09c0da413f53"} {"level":"info","ts":"2026-05-20T21:24:27.066764Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-05-20T21:24:27.066882Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d82047944f922143 switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T21:24:27.067006Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"d82047944f922143 became follower at term 0"} {"level":"info","ts":"2026-05-20T21:24:27.067029Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft d82047944f922143 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T21:24:27.067047Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"d82047944f922143 became follower at term 1"} {"level":"info","ts":"2026-05-20T21:24:27.067168Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d82047944f922143 switched to configuration voters=(15573526213762883907)"} {"level":"warn","ts":"2026-05-20T21:24:27.072420Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T21:24:27.076164Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T21:24:27.081762Z","caller":"storage/quota.go:93","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-20T21:24:27.082536Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"d82047944f922143","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T21:24:27.082893Z","caller":"embed/etcd.go:766","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-20T21:24:27.082895Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d82047944f922143","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T21:24:27.083034Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.19.213.103:2380"} {"level":"info","ts":"2026-05-20T21:24:27.083139Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.19.213.103:2380"} {"level":"info","ts":"2026-05-20T21:24:27.083226Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T21:24:27.083450Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d82047944f922143 switched to configuration voters=(15573526213762883907)"} {"level":"info","ts":"2026-05-20T21:24:27.083552Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"d82047944f922143","initial-advertise-peer-urls":["https://199.19.213.103:2380"],"listen-peer-urls":["https://199.19.213.103:2380"],"advertise-client-urls":["https://199.19.213.103:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.103:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T21:24:27.083617Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T21:24:27.083619Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T21:24:27.083864Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"223a09c0da413f53","local-member-id":"d82047944f922143","added-peer-id":"d82047944f922143","added-peer-peer-urls":["https://199.19.213.103:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-05-20T21:24:27.083958Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-20T21:24:27.267815Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"d82047944f922143 is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T21:24:27.267881Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"d82047944f922143 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T21:24:27.268035Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"d82047944f922143 received MsgPreVoteResp from d82047944f922143 at term 1"} {"level":"info","ts":"2026-05-20T21:24:27.268063Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"d82047944f922143 has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-20T21:24:27.268087Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"d82047944f922143 became candidate at term 2"} {"level":"info","ts":"2026-05-20T21:24:27.437363Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"d82047944f922143 received MsgVoteResp from d82047944f922143 at term 2"} {"level":"info","ts":"2026-05-20T21:24:27.437588Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"d82047944f922143 has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-05-20T21:24:27.437654Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"d82047944f922143 became leader at term 2"} {"level":"info","ts":"2026-05-20T21:24:27.437701Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: d82047944f922143 elected leader d82047944f922143 at term 2"} {"level":"info","ts":"2026-05-20T21:24:27.565513Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T21:24:27.715555Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"d82047944f922143","local-member-attributes":"{Name:controller ClientURLs:[https://199.19.213.103:2379]}","cluster-id":"223a09c0da413f53","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T21:24:27.715591Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T21:24:27.715777Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T21:24:27.715983Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T21:24:27.716004Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T21:24:27.717003Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-05-20T21:24:27.717172Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-05-20T21:24:27.717263Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-05-20T21:24:27.723009Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.103:2379"} {"level":"info","ts":"2026-05-20T21:24:27.725419Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-20T21:24:27.766240Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"223a09c0da413f53","local-member-id":"d82047944f922143","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T21:24:27.766390Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T21:24:27.766456Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-05-20T21:24:27.766637Z","caller":"version/monitor.go:116","msg":"cluster version differs from storage version.","cluster-version":"3.6.0","storage-version":"3.5.0"} {"level":"info","ts":"2026-05-20T21:24:27.766713Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"warn","ts":"2026-05-20T21:24:28.011453Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52826","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.013003Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52836","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.033575Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52850","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.044835Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52864","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.060762Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52922","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.075623Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52948","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.092010Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52978","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.103501Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53000","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.115821Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53020","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.127943Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53022","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.139649Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53054","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.154695Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53056","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.164997Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53076","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.179283Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53100","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.190466Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53102","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.203696Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53120","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.213268Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53140","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.221012Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53166","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.230939Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53190","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.244122Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53208","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.253576Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53238","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.264706Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53258","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.302316Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53270","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.314070Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53280","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.324051Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53290","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.334180Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53304","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.346936Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53330","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.355972Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53338","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.366740Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53354","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.387085Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53372","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.396145Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53390","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.404321Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53402","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.419478Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53414","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.427360Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53436","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.437637Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53458","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.451958Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53474","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.458481Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53500","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.467849Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53524","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.478216Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53552","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.492729Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53574","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.515318Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53578","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.522980Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53602","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.530325Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53628","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.540091Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53638","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.551804Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53646","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.562410Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53664","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.572137Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53688","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.581846Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53698","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.590791Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53716","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.599312Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53726","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.608935Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53730","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.621636Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53740","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.629249Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53754","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.636643Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53776","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.643587Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53782","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.654492Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53798","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.667741Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53816","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.676208Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53832","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.685652Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53842","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.717446Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53864","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.725526Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53902","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.733465Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53934","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:24:28.787509Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53954","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-20T21:24:29.319881Z","caller":"traceutil/trace.go:172","msg":"trace[109528014] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"105.038845ms","start":"2026-05-20T21:24:29.214827Z","end":"2026-05-20T21:24:29.319866Z","steps":["trace[109528014] 'process raft request' (duration: 104.874305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:29.820016Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654894471,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T21:24:29.831175Z","caller":"traceutil/trace.go:172","msg":"trace[395893566] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:5; }","duration":"511.369766ms","start":"2026-05-20T21:24:29.319701Z","end":"2026-05-20T21:24:29.831071Z","steps":["trace[395893566] 'read index received' (duration: 511.361086ms)","trace[395893566] 'applied index is now lower than readState.Index' (duration: 7.39µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:29.831850Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"546.792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.103\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-20T21:24:29.831851Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"569.842757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T21:24:29.831897Z","caller":"traceutil/trace.go:172","msg":"trace[2030064894] range","detail":"{range_begin:/registry/masterleases/199.19.213.103; range_end:; response_count:0; response_revision:2; }","duration":"546.86086ms","start":"2026-05-20T21:24:29.285027Z","end":"2026-05-20T21:24:29.831888Z","steps":["trace[2030064894] 'agreement among raft nodes before linearized reading' (duration: 546.09618ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:29.831915Z","caller":"traceutil/trace.go:172","msg":"trace[1174634462] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:2; }","duration":"569.921027ms","start":"2026-05-20T21:24:29.261978Z","end":"2026-05-20T21:24:29.831899Z","steps":["trace[1174634462] 'agreement among raft nodes before linearized reading' (duration: 569.223897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:29.831968Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.261950Z","time spent":"570.006237ms","remote":"127.0.0.1:53042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:24:29.831926Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.284188Z","time spent":"547.732161ms","remote":"127.0.0.1:52880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.103\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:24:29.832432Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"546.906351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T21:24:29.832493Z","caller":"traceutil/trace.go:172","msg":"trace[1232680022] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:2; }","duration":"546.972491ms","start":"2026-05-20T21:24:29.285509Z","end":"2026-05-20T21:24:29.832482Z","steps":["trace[1232680022] 'agreement among raft nodes before linearized reading' (duration: 545.58108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:29.832522Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.285493Z","time spent":"547.021161ms","remote":"127.0.0.1:53042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:24:29.832985Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"510.192924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/controller\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T21:24:29.833037Z","caller":"traceutil/trace.go:172","msg":"trace[1497083290] range","detail":"{range_begin:/registry/minions/controller; range_end:; response_count:0; response_revision:10; }","duration":"510.247664ms","start":"2026-05-20T21:24:29.322779Z","end":"2026-05-20T21:24:29.833027Z","steps":["trace[1497083290] 'agreement among raft nodes before linearized reading' (duration: 510.169534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:29.833068Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.322748Z","time spent":"510.312414ms","remote":"127.0.0.1:53180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":32,"response count":0,"response size":27,"request content":"key:\"/registry/minions/controller\" limit:1 "} {"level":"info","ts":"2026-05-20T21:24:29.833408Z","caller":"traceutil/trace.go:172","msg":"trace[14266728] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"547.156881ms","start":"2026-05-20T21:24:29.286231Z","end":"2026-05-20T21:24:29.833388Z","steps":["trace[14266728] 'process raft request' (duration: 546.644221ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:29.833520Z","caller":"traceutil/trace.go:172","msg":"trace[38256116] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"547.813421ms","start":"2026-05-20T21:24:29.285671Z","end":"2026-05-20T21:24:29.833485Z","steps":["trace[38256116] 'process raft request' (duration: 547.003201ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:29.833752Z","caller":"traceutil/trace.go:172","msg":"trace[1263679726] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"548.005421ms","start":"2026-05-20T21:24:29.285729Z","end":"2026-05-20T21:24:29.833735Z","steps":["trace[1263679726] 'process raft request' (duration: 546.993071ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:29.833774Z","caller":"traceutil/trace.go:172","msg":"trace[45362603] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"548.865352ms","start":"2026-05-20T21:24:29.284841Z","end":"2026-05-20T21:24:29.833707Z","steps":["trace[45362603] 'process raft request' (duration: 546.287591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:29.833978Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.285714Z","time spent":"548.070672ms","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":688,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:24:29.833980Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.284817Z","time spent":"549.069713ms","remote":"127.0.0.1:53042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:24:29.834135Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"496.420265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-20T21:24:29.834311Z","caller":"traceutil/trace.go:172","msg":"trace[921830576] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:10; }","duration":"496.713455ms","start":"2026-05-20T21:24:29.337550Z","end":"2026-05-20T21:24:29.834264Z","steps":["trace[921830576] 'agreement among raft nodes before linearized reading' (duration: 496.149054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:29.834437Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.337537Z","time spent":"496.886515ms","remote":"127.0.0.1:53042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"info","ts":"2026-05-20T21:24:29.834727Z","caller":"traceutil/trace.go:172","msg":"trace[69139176] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"548.378402ms","start":"2026-05-20T21:24:29.286305Z","end":"2026-05-20T21:24:29.834683Z","steps":["trace[69139176] 'process raft request' (duration: 546.603081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:29.834860Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.286294Z","time spent":"548.477782ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:24:29.834903Z","caller":"traceutil/trace.go:172","msg":"trace[716829882] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"548.854982ms","start":"2026-05-20T21:24:29.286035Z","end":"2026-05-20T21:24:29.834890Z","steps":["trace[716829882] 'process raft request' (duration: 546.753351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:29.835025Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.286022Z","time spent":"548.924542ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:24:29.835262Z","caller":"traceutil/trace.go:172","msg":"trace[693552111] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"549.054423ms","start":"2026-05-20T21:24:29.286193Z","end":"2026-05-20T21:24:29.835248Z","steps":["trace[693552111] 'process raft request' (duration: 546.645901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:29.835334Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.286187Z","time spent":"549.118213ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:24:29.835795Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.286227Z","time spent":"547.234541ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:24:29.835897Z","caller":"traceutil/trace.go:172","msg":"trace[318966043] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"549.879993ms","start":"2026-05-20T21:24:29.285982Z","end":"2026-05-20T21:24:29.835862Z","steps":["trace[318966043] 'process raft request' (duration: 546.766471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:29.835968Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.285977Z","time spent":"549.958613ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:24:29.835853Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:29.285665Z","time spent":"547.931181ms","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":280,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:24:35.070613Z","caller":"traceutil/trace.go:172","msg":"trace[1037279366] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"147.197325ms","start":"2026-05-20T21:24:34.923393Z","end":"2026-05-20T21:24:35.070590Z","steps":["trace[1037279366] 'process raft request' (duration: 147.085645ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:35.465000Z","caller":"traceutil/trace.go:172","msg":"trace[377247345] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"229.692684ms","start":"2026-05-20T21:24:35.235283Z","end":"2026-05-20T21:24:35.464976Z","steps":["trace[377247345] 'process raft request' (duration: 229.564724ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:35.465052Z","caller":"traceutil/trace.go:172","msg":"trace[1436530617] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"384.951174ms","start":"2026-05-20T21:24:35.080024Z","end":"2026-05-20T21:24:35.464975Z","steps":["trace[1436530617] 'process raft request' (duration: 307.750339ms)","trace[1436530617] 'compare' (duration: 76.923115ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:35.465209Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:35.080012Z","time spent":"385.141825ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:24:35.698955Z","caller":"traceutil/trace.go:172","msg":"trace[162004273] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"223.93129ms","start":"2026-05-20T21:24:35.475002Z","end":"2026-05-20T21:24:35.698933Z","steps":["trace[162004273] 'process raft request' (duration: 223.81887ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:35.705735Z","caller":"traceutil/trace.go:172","msg":"trace[2082845447] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"131.738254ms","start":"2026-05-20T21:24:35.573969Z","end":"2026-05-20T21:24:35.705707Z","steps":["trace[2082845447] 'process raft request' (duration: 131.632814ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:36.185431Z","caller":"traceutil/trace.go:172","msg":"trace[810718649] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"162.175606ms","start":"2026-05-20T21:24:36.023230Z","end":"2026-05-20T21:24:36.185406Z","steps":["trace[810718649] 'process raft request' (duration: 161.964596ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:36.558480Z","caller":"traceutil/trace.go:172","msg":"trace[606672097] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:316; }","duration":"234.896657ms","start":"2026-05-20T21:24:36.323553Z","end":"2026-05-20T21:24:36.558450Z","steps":["trace[606672097] 'read index received' (duration: 234.867607ms)","trace[606672097] 'applied index is now lower than readState.Index' (duration: 26.64µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:24:36.558553Z","caller":"traceutil/trace.go:172","msg":"trace[1400691050] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"284.100343ms","start":"2026-05-20T21:24:36.274431Z","end":"2026-05-20T21:24:36.558531Z","steps":["trace[1400691050] 'process raft request' (duration: 283.974772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:36.558789Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"235.215138ms","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-05-20T21:24:36.558892Z","caller":"traceutil/trace.go:172","msg":"trace[419129189] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:307; }","duration":"235.336368ms","start":"2026-05-20T21:24:36.323535Z","end":"2026-05-20T21:24:36.558872Z","steps":["trace[419129189] 'agreement among raft nodes before linearized reading' (duration: 235.050808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:36.573160Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.131892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-20T21:24:36.573203Z","caller":"traceutil/trace.go:172","msg":"trace[2098181448] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:307; }","duration":"101.184512ms","start":"2026-05-20T21:24:36.472009Z","end":"2026-05-20T21:24:36.573193Z","steps":["trace[2098181448] 'agreement among raft nodes before linearized reading' (duration: 101.039182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:36.573318Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"150.554277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-20T21:24:36.573438Z","caller":"traceutil/trace.go:172","msg":"trace[1987781783] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:307; }","duration":"150.667617ms","start":"2026-05-20T21:24:36.422733Z","end":"2026-05-20T21:24:36.573401Z","steps":["trace[1987781783] 'agreement among raft nodes before linearized reading' (duration: 150.472157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:36.573368Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"102.867933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T21:24:36.574441Z","caller":"traceutil/trace.go:172","msg":"trace[975736995] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:307; }","duration":"103.940914ms","start":"2026-05-20T21:24:36.470481Z","end":"2026-05-20T21:24:36.574421Z","steps":["trace[975736995] 'agreement among raft nodes before linearized reading' (duration: 102.692603ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:36.573873Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"201.309253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-20T21:24:36.574553Z","caller":"traceutil/trace.go:172","msg":"trace[731713442] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:307; }","duration":"201.991234ms","start":"2026-05-20T21:24:36.372543Z","end":"2026-05-20T21:24:36.574534Z","steps":["trace[731713442] 'agreement among raft nodes before linearized reading' (duration: 200.471903ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:36.573902Z","caller":"traceutil/trace.go:172","msg":"trace[1902006270] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"293.08216ms","start":"2026-05-20T21:24:36.280801Z","end":"2026-05-20T21:24:36.573884Z","steps":["trace[1902006270] 'process raft request' (duration: 292.267229ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:36.681386Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.830506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-20T21:24:36.681442Z","caller":"traceutil/trace.go:172","msg":"trace[290738513] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"114.240171ms","start":"2026-05-20T21:24:36.567171Z","end":"2026-05-20T21:24:36.681411Z","steps":["trace[290738513] 'process raft request' (duration: 84.40955ms)","trace[290738513] 'compare' (duration: 29.663761ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:24:36.681466Z","caller":"traceutil/trace.go:172","msg":"trace[939478942] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"103.390484ms","start":"2026-05-20T21:24:36.578058Z","end":"2026-05-20T21:24:36.681449Z","steps":["trace[939478942] 'process raft request' (duration: 103.362024ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:36.681468Z","caller":"traceutil/trace.go:172","msg":"trace[595308000] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:308; }","duration":"106.923466ms","start":"2026-05-20T21:24:36.574529Z","end":"2026-05-20T21:24:36.681452Z","steps":["trace[595308000] 'agreement among raft nodes before linearized reading' (duration: 77.027775ms)","trace[595308000] 'range keys from in-memory index tree' (duration: 29.700921ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:24:36.681720Z","caller":"traceutil/trace.go:172","msg":"trace[1538499278] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"103.656175ms","start":"2026-05-20T21:24:36.578057Z","end":"2026-05-20T21:24:36.681713Z","steps":["trace[1538499278] 'process raft request' (duration: 103.333374ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:36.681905Z","caller":"traceutil/trace.go:172","msg":"trace[1331842044] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"104.811125ms","start":"2026-05-20T21:24:36.577062Z","end":"2026-05-20T21:24:36.681873Z","steps":["trace[1331842044] 'process raft request' (duration: 104.296094ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:36.870613Z","caller":"traceutil/trace.go:172","msg":"trace[235975093] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:322; }","duration":"146.405134ms","start":"2026-05-20T21:24:36.724182Z","end":"2026-05-20T21:24:36.870587Z","steps":["trace[235975093] 'read index received' (duration: 146.395194ms)","trace[235975093] 'applied index is now lower than readState.Index' (duration: 8µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:38.525448Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.178544971s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:24:38.525543Z","caller":"traceutil/trace.go:172","msg":"trace[566009839] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:312; }","duration":"1.178657681s","start":"2026-05-20T21:24:37.346869Z","end":"2026-05-20T21:24:38.525527Z","steps":["trace[566009839] 'range keys from in-memory index tree' (duration: 1.178524991s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:38.525784Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.801603797s","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":"info","ts":"2026-05-20T21:24:38.525819Z","caller":"traceutil/trace.go:172","msg":"trace[1603023379] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:312; }","duration":"1.801637817s","start":"2026-05-20T21:24:36.724169Z","end":"2026-05-20T21:24:38.525807Z","steps":["trace[1603023379] 'agreement among raft nodes before linearized reading' (duration: 146.535095ms)","trace[1603023379] 'range keys from in-memory index tree' (duration: 1.654969032s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:38.525850Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:36.724140Z","time spent":"1.801701417s","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:24:38.526167Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.655243563s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:24:38.526264Z","caller":"traceutil/trace.go:172","msg":"trace[927716539] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:322; }","duration":"1.655568653s","start":"2026-05-20T21:24:36.870680Z","end":"2026-05-20T21:24:38.526248Z","steps":["trace[927716539] 'read index received' (duration: 39.121µs)","trace[927716539] 'applied index is now lower than readState.Index' (duration: 1.655528152s)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:24:38.526339Z","caller":"traceutil/trace.go:172","msg":"trace[1260956536] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"1.840408104s","start":"2026-05-20T21:24:36.685920Z","end":"2026-05-20T21:24:38.526328Z","steps":["trace[1260956536] 'process raft request' (duration: 184.718631ms)","trace[1260956536] 'compare' (duration: 1.654964332s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:38.526386Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:36.685890Z","time spent":"1.840476684s","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:24:38.526658Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.702420796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-05-20T21:24:38.526695Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.752586952s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 ","response":"range_response_count:1 size:238"} {"level":"info","ts":"2026-05-20T21:24:38.526735Z","caller":"traceutil/trace.go:172","msg":"trace[1969339242] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:313; }","duration":"1.702503926s","start":"2026-05-20T21:24:36.824213Z","end":"2026-05-20T21:24:38.526716Z","steps":["trace[1969339242] 'agreement among raft nodes before linearized reading' (duration: 1.702291606s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:38.526801Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:36.824186Z","time spent":"1.702599556s","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T21:24:38.526798Z","caller":"traceutil/trace.go:172","msg":"trace[448548323] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner; range_end:; response_count:1; response_revision:313; }","duration":"1.752694592s","start":"2026-05-20T21:24:36.774079Z","end":"2026-05-20T21:24:38.526773Z","steps":["trace[448548323] 'agreement among raft nodes before linearized reading' (duration: 1.752446192s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:38.526860Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:36.774054Z","time spent":"1.752793122s","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":261,"request content":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:24:38.527449Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.052280252s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-20T21:24:38.527870Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.602723515s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-20T21:24:38.527940Z","caller":"traceutil/trace.go:172","msg":"trace[940091248] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:313; }","duration":"1.602795695s","start":"2026-05-20T21:24:36.925128Z","end":"2026-05-20T21:24:38.527924Z","steps":["trace[940091248] 'agreement among raft nodes before linearized reading' (duration: 1.602624215s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:38.527995Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:36.925066Z","time spent":"1.602917535s","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:24:38.528056Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.453363938s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-20T21:24:38.527941Z","caller":"traceutil/trace.go:172","msg":"trace[337669046] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"1.053893843s","start":"2026-05-20T21:24:37.474034Z","end":"2026-05-20T21:24:38.527928Z","steps":["trace[337669046] 'process raft request' (duration: 1.053822083s)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:38.528155Z","caller":"traceutil/trace.go:172","msg":"trace[131264228] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:314; }","duration":"1.453450068s","start":"2026-05-20T21:24:37.074681Z","end":"2026-05-20T21:24:38.528131Z","steps":["trace[131264228] 'agreement among raft nodes before linearized reading' (duration: 1.453292758s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:38.528218Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:37.074666Z","time spent":"1.453538668s","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:24:38.527912Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.503700154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-20T21:24:38.528360Z","caller":"traceutil/trace.go:172","msg":"trace[2031457372] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:313; }","duration":"1.504135424s","start":"2026-05-20T21:24:37.024183Z","end":"2026-05-20T21:24:38.528318Z","steps":["trace[2031457372] 'agreement among raft nodes before linearized reading' (duration: 1.503526514s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:38.528447Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:37.024147Z","time spent":"1.504256774s","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:24:38.528480Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:37.473991Z","time spent":"1.054158433s","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:24:38.528972Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.653674681s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-20T21:24:38.529140Z","caller":"traceutil/trace.go:172","msg":"trace[1467721377] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:313; }","duration":"1.655023562s","start":"2026-05-20T21:24:36.874090Z","end":"2026-05-20T21:24:38.529114Z","steps":["trace[1467721377] 'agreement among raft nodes before linearized reading' (duration: 1.653596771s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:38.529184Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:36.874064Z","time spent":"1.655107992s","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:24:38.529888Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.555718022s","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-05-20T21:24:38.530002Z","caller":"traceutil/trace.go:172","msg":"trace[500600695] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:314; }","duration":"1.555833412s","start":"2026-05-20T21:24:36.974151Z","end":"2026-05-20T21:24:38.529984Z","steps":["trace[500600695] 'agreement among raft nodes before linearized reading' (duration: 1.555542801s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:38.530148Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:36.974127Z","time spent":"1.555955672s","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" limit:1 "} {"level":"info","ts":"2026-05-20T21:24:38.539465Z","caller":"traceutil/trace.go:172","msg":"trace[891213329] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"827.2841ms","start":"2026-05-20T21:24:37.712166Z","end":"2026-05-20T21:24:38.539450Z","steps":["trace[891213329] 'process raft request' (duration: 827.05617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:38.539579Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:37.712136Z","time spent":"827.389901ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:24:42.695494Z","caller":"traceutil/trace.go:172","msg":"trace[807204521] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:371; }","duration":"164.622878ms","start":"2026-05-20T21:24:42.530849Z","end":"2026-05-20T21:24:42.695472Z","steps":["trace[807204521] 'read index received' (duration: 164.614948ms)","trace[807204521] 'applied index is now lower than readState.Index' (duration: 6.42µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:42.695852Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"164.949338ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:24:42.696317Z","caller":"traceutil/trace.go:172","msg":"trace[181391828] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:360; }","duration":"165.458758ms","start":"2026-05-20T21:24:42.530842Z","end":"2026-05-20T21:24:42.696301Z","steps":["trace[181391828] 'agreement among raft nodes before linearized reading' (duration: 164.867738ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:42.695906Z","caller":"traceutil/trace.go:172","msg":"trace[1451761635] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"303.589157ms","start":"2026-05-20T21:24:42.392286Z","end":"2026-05-20T21:24:42.695875Z","steps":["trace[1451761635] 'process raft request' (duration: 303.426277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:42.696863Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:42.392268Z","time spent":"304.418198ms","remote":"127.0.0.1:53196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4834,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:24:42.705345Z","caller":"traceutil/trace.go:172","msg":"trace[1058342527] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"124.450589ms","start":"2026-05-20T21:24:42.580876Z","end":"2026-05-20T21:24:42.705326Z","steps":["trace[1058342527] 'process raft request' (duration: 124.411599ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:42.705473Z","caller":"traceutil/trace.go:172","msg":"trace[959362959] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"163.482527ms","start":"2026-05-20T21:24:42.541980Z","end":"2026-05-20T21:24:42.705463Z","steps":["trace[959362959] 'process raft request' (duration: 163.208797ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:42.705544Z","caller":"traceutil/trace.go:172","msg":"trace[732521603] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"150.780778ms","start":"2026-05-20T21:24:42.554750Z","end":"2026-05-20T21:24:42.705530Z","steps":["trace[732521603] 'process raft request' (duration: 150.515858ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:44.236348Z","caller":"traceutil/trace.go:172","msg":"trace[1133349958] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:378; }","duration":"379.294491ms","start":"2026-05-20T21:24:43.857032Z","end":"2026-05-20T21:24:44.236327Z","steps":["trace[1133349958] 'read index received' (duration: 379.286151ms)","trace[1133349958] 'applied index is now lower than readState.Index' (duration: 7.39µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:24:44.236519Z","caller":"traceutil/trace.go:172","msg":"trace[1954934148] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"418.144298ms","start":"2026-05-20T21:24:43.818361Z","end":"2026-05-20T21:24:44.236505Z","steps":["trace[1954934148] 'process raft request' (duration: 418.015798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:44.236632Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:43.818341Z","time spent":"418.225228ms","remote":"127.0.0.1:53196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7230,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:24:44.236654Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"379.587171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:24:44.236809Z","caller":"traceutil/trace.go:172","msg":"trace[1805425133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:368; }","duration":"379.764792ms","start":"2026-05-20T21:24:43.857017Z","end":"2026-05-20T21:24:44.236781Z","steps":["trace[1805425133] 'agreement among raft nodes before linearized reading' (duration: 379.407721ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:44.236870Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:43.857001Z","time spent":"379.859042ms","remote":"127.0.0.1:52834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T21:24:44.400225Z","caller":"traceutil/trace.go:172","msg":"trace[883041609] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"154.16566ms","start":"2026-05-20T21:24:44.246024Z","end":"2026-05-20T21:24:44.400189Z","steps":["trace[883041609] 'process raft request' (duration: 127.484631ms)","trace[883041609] 'compare' (duration: 26.490049ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:44.678356Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"146.925765ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:24:44.678490Z","caller":"traceutil/trace.go:172","msg":"trace[864786929] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:369; }","duration":"147.082325ms","start":"2026-05-20T21:24:44.531378Z","end":"2026-05-20T21:24:44.678460Z","steps":["trace[864786929] 'range keys from in-memory index tree' (duration: 146.856795ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:44.912031Z","caller":"traceutil/trace.go:172","msg":"trace[104197544] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:381; }","duration":"106.546076ms","start":"2026-05-20T21:24:44.805296Z","end":"2026-05-20T21:24:44.911842Z","steps":["trace[104197544] 'read index received' (duration: 106.530146ms)","trace[104197544] 'applied index is now lower than readState.Index' (duration: 13.15µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:44.951010Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"226.560772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T21:24:44.951137Z","caller":"traceutil/trace.go:172","msg":"trace[4663427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:370; }","duration":"226.672752ms","start":"2026-05-20T21:24:44.724420Z","end":"2026-05-20T21:24:44.951093Z","steps":["trace[4663427] 'agreement among raft nodes before linearized reading' (duration: 187.562584ms)","trace[4663427] 'range keys from in-memory index tree' (duration: 38.521187ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:24:44.951389Z","caller":"traceutil/trace.go:172","msg":"trace[473941800] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"240.460672ms","start":"2026-05-20T21:24:44.710914Z","end":"2026-05-20T21:24:44.951374Z","steps":["trace[473941800] 'process raft request' (duration: 201.030364ms)","trace[473941800] 'compare' (duration: 39.003638ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:24:44.951822Z","caller":"traceutil/trace.go:172","msg":"trace[1490928208] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"141.850981ms","start":"2026-05-20T21:24:44.809946Z","end":"2026-05-20T21:24:44.951797Z","steps":["trace[1490928208] 'process raft request' (duration: 141.756911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:46.396244Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"166.727479ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-20T21:24:47.213568Z","caller":"traceutil/trace.go:172","msg":"trace[1803160722] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:386; }","duration":"246.702917ms","start":"2026-05-20T21:24:46.966836Z","end":"2026-05-20T21:24:47.213539Z","steps":["trace[1803160722] 'read index received' (duration: 246.691877ms)","trace[1803160722] 'applied index is now lower than readState.Index' (duration: 9.19µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:47.272997Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"306.138959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T21:24:47.273070Z","caller":"traceutil/trace.go:172","msg":"trace[122865038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:374; }","duration":"306.224339ms","start":"2026-05-20T21:24:46.966830Z","end":"2026-05-20T21:24:47.273054Z","steps":["trace[122865038] 'agreement among raft nodes before linearized reading' (duration: 246.801917ms)","trace[122865038] 'range keys from in-memory index tree' (duration: 59.236272ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:47.273115Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:46.966820Z","time spent":"306.273369ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-05-20T21:24:47.273161Z","caller":"traceutil/trace.go:172","msg":"trace[957649436] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"315.152455ms","start":"2026-05-20T21:24:46.957926Z","end":"2026-05-20T21:24:47.273078Z","steps":["trace[957649436] 'process raft request' (duration: 255.742593ms)","trace[957649436] 'compare' (duration: 59.215632ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:24:47.273506Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:46.957894Z","time spent":"315.410675ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:24:47.273559Z","caller":"traceutil/trace.go:172","msg":"trace[540695222] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"313.069664ms","start":"2026-05-20T21:24:46.960458Z","end":"2026-05-20T21:24:47.273528Z","steps":["trace[540695222] 'process raft request' (duration: 312.927693ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:24:47.273752Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:46.960437Z","time spent":"313.211304ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:24:59.523571Z","caller":"traceutil/trace.go:172","msg":"trace[931158729] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"114.216922ms","start":"2026-05-20T21:24:59.409326Z","end":"2026-05-20T21:24:59.523543Z","steps":["trace[931158729] 'process raft request' (duration: 29.535681ms)","trace[931158729] 'compare' (duration: 84.514251ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:24:59.523750Z","caller":"traceutil/trace.go:172","msg":"trace[1379941173] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"113.273871ms","start":"2026-05-20T21:24:59.410451Z","end":"2026-05-20T21:24:59.523725Z","steps":["trace[1379941173] 'process raft request' (duration: 113.058641ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:24:59.812214Z","caller":"traceutil/trace.go:172","msg":"trace[1865278635] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"271.358644ms","start":"2026-05-20T21:24:59.540823Z","end":"2026-05-20T21:24:59.812181Z","steps":["trace[1865278635] 'process raft request' (duration: 266.38116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:00.131739Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"272.495184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:00.131829Z","caller":"traceutil/trace.go:172","msg":"trace[143714998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"272.586804ms","start":"2026-05-20T21:24:59.859220Z","end":"2026-05-20T21:25:00.131807Z","steps":["trace[143714998] 'agreement among raft nodes before linearized reading' (duration: 57.533771ms)","trace[143714998] 'range keys from in-memory index tree' (duration: 214.927383ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:00.132072Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"215.195553ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:25:00.132235Z","caller":"traceutil/trace.go:172","msg":"trace[79365104] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"312.781194ms","start":"2026-05-20T21:24:59.819432Z","end":"2026-05-20T21:25:00.132213Z","steps":["trace[79365104] 'process raft request' (duration: 97.36494ms)","trace[79365104] 'compare' (duration: 214.861233ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:00.132302Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:24:59.819402Z","time spent":"312.879024ms","remote":"127.0.0.1:53748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3960,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:00.288569Z","caller":"traceutil/trace.go:172","msg":"trace[501988335] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"148.314086ms","start":"2026-05-20T21:25:00.140227Z","end":"2026-05-20T21:25:00.288541Z","steps":["trace[501988335] 'process raft request' (duration: 148.231386ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:00.288625Z","caller":"traceutil/trace.go:172","msg":"trace[1434414621] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"151.142288ms","start":"2026-05-20T21:25:00.137401Z","end":"2026-05-20T21:25:00.288543Z","steps":["trace[1434414621] 'process raft request' (duration: 143.311693ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:00.538510Z","caller":"traceutil/trace.go:172","msg":"trace[356662422] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:429; }","duration":"155.931702ms","start":"2026-05-20T21:25:00.382547Z","end":"2026-05-20T21:25:00.538479Z","steps":["trace[356662422] 'read index received' (duration: 155.918152ms)","trace[356662422] 'applied index is now lower than readState.Index' (duration: 12.14µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:00.540895Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"158.348303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-66bc5c9577-65rnr\" limit:1 ","response":"range_response_count:1 size:4357"} {"level":"info","ts":"2026-05-20T21:25:00.541287Z","caller":"traceutil/trace.go:172","msg":"trace[1788474042] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"229.316634ms","start":"2026-05-20T21:25:00.311949Z","end":"2026-05-20T21:25:00.541266Z","steps":["trace[1788474042] 'process raft request' (duration: 226.645612ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:00.541270Z","caller":"traceutil/trace.go:172","msg":"trace[2024240605] range","detail":"{range_begin:/registry/pods/kube-system/coredns-66bc5c9577-65rnr; range_end:; response_count:1; response_revision:415; }","duration":"158.736114ms","start":"2026-05-20T21:25:00.382505Z","end":"2026-05-20T21:25:00.541242Z","steps":["trace[2024240605] 'agreement among raft nodes before linearized reading' (duration: 156.083162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:00.541673Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"154.5636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" limit:1 ","response":"range_response_count:1 size:4477"} {"level":"info","ts":"2026-05-20T21:25:00.541737Z","caller":"traceutil/trace.go:172","msg":"trace[222084298] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:416; }","duration":"154.62828ms","start":"2026-05-20T21:25:00.387092Z","end":"2026-05-20T21:25:00.541720Z","steps":["trace[222084298] 'agreement among raft nodes before linearized reading' (duration: 154.4128ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:00.542145Z","caller":"traceutil/trace.go:172","msg":"trace[1580140881] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"160.924625ms","start":"2026-05-20T21:25:00.381167Z","end":"2026-05-20T21:25:00.542092Z","steps":["trace[1580140881] 'process raft request' (duration: 160.025805ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:11.591886Z","caller":"traceutil/trace.go:172","msg":"trace[199528667] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"194.820999ms","start":"2026-05-20T21:25:11.397045Z","end":"2026-05-20T21:25:11.591866Z","steps":["trace[199528667] 'process raft request' (duration: 194.663079ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:12.025934Z","caller":"traceutil/trace.go:172","msg":"trace[1209147760] linearizableReadLoop","detail":"{readStateIndex:478; appliedIndex:478; }","duration":"166.622589ms","start":"2026-05-20T21:25:11.859283Z","end":"2026-05-20T21:25:12.025906Z","steps":["trace[1209147760] 'read index received' (duration: 166.612479ms)","trace[1209147760] 'applied index is now lower than readState.Index' (duration: 9.01µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:12.026121Z","caller":"traceutil/trace.go:172","msg":"trace[1395112877] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"276.332018ms","start":"2026-05-20T21:25:11.749757Z","end":"2026-05-20T21:25:12.026089Z","steps":["trace[1395112877] 'process raft request' (duration: 276.213277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:12.026182Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"166.89085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:12.027149Z","caller":"traceutil/trace.go:172","msg":"trace[1433512348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:462; }","duration":"167.81316ms","start":"2026-05-20T21:25:11.859259Z","end":"2026-05-20T21:25:12.027072Z","steps":["trace[1433512348] 'agreement among raft nodes before linearized reading' (duration: 166.81246ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:12.247935Z","caller":"traceutil/trace.go:172","msg":"trace[388367658] linearizableReadLoop","detail":"{readStateIndex:479; appliedIndex:479; }","duration":"219.498827ms","start":"2026-05-20T21:25:12.028400Z","end":"2026-05-20T21:25:12.247899Z","steps":["trace[388367658] 'read index received' (duration: 219.482517ms)","trace[388367658] 'applied index is now lower than readState.Index' (duration: 14.69µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:12.319964Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"291.539148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:12.320053Z","caller":"traceutil/trace.go:172","msg":"trace[2145656726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:462; }","duration":"291.639759ms","start":"2026-05-20T21:25:12.028393Z","end":"2026-05-20T21:25:12.320033Z","steps":["trace[2145656726] 'agreement among raft nodes before linearized reading' (duration: 219.582737ms)","trace[2145656726] 'range keys from in-memory index tree' (duration: 71.897581ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:12.320315Z","caller":"traceutil/trace.go:172","msg":"trace[319610100] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"568.961897ms","start":"2026-05-20T21:25:11.751321Z","end":"2026-05-20T21:25:12.320283Z","steps":["trace[319610100] 'process raft request' (duration: 496.620155ms)","trace[319610100] 'compare' (duration: 72.143372ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:12.320525Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:11.751274Z","time spent":"569.146947ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:14.574175Z","caller":"traceutil/trace.go:172","msg":"trace[937211509] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"244.755974ms","start":"2026-05-20T21:25:14.329380Z","end":"2026-05-20T21:25:14.574136Z","steps":["trace[937211509] 'process raft request' (duration: 244.418104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.552922Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654895580,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T21:25:18.699905Z","caller":"traceutil/trace.go:172","msg":"trace[682353876] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:526; }","duration":"647.578382ms","start":"2026-05-20T21:25:18.052290Z","end":"2026-05-20T21:25:18.699869Z","steps":["trace[682353876] 'read index received' (duration: 647.564292ms)","trace[682353876] 'applied index is now lower than readState.Index' (duration: 12.07µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:18.700128Z","caller":"traceutil/trace.go:172","msg":"trace[1008258049] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"687.03298ms","start":"2026-05-20T21:25:18.013042Z","end":"2026-05-20T21:25:18.700075Z","steps":["trace[1008258049] 'process raft request' (duration: 686.87872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.700220Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"647.904962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T21:25:18.700313Z","caller":"traceutil/trace.go:172","msg":"trace[1083637488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:509; }","duration":"648.011412ms","start":"2026-05-20T21:25:18.052287Z","end":"2026-05-20T21:25:18.700299Z","steps":["trace[1083637488] 'agreement among raft nodes before linearized reading' (duration: 647.740272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.700359Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.013014Z","time spent":"687.27059ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:25:18.700409Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.052277Z","time spent":"648.104603ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:18.711838Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"122.971858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T21:25:18.711915Z","caller":"traceutil/trace.go:172","msg":"trace[642333961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:509; }","duration":"123.052348ms","start":"2026-05-20T21:25:18.588847Z","end":"2026-05-20T21:25:18.711899Z","steps":["trace[642333961] 'agreement among raft nodes before linearized reading' (duration: 122.884578ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:18.712133Z","caller":"traceutil/trace.go:172","msg":"trace[801098758] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"696.552608ms","start":"2026-05-20T21:25:18.015536Z","end":"2026-05-20T21:25:18.712088Z","steps":["trace[801098758] 'process raft request' (duration: 696.201548ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:18.712185Z","caller":"traceutil/trace.go:172","msg":"trace[413442561] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"683.593798ms","start":"2026-05-20T21:25:18.028575Z","end":"2026-05-20T21:25:18.712169Z","steps":["trace[413442561] 'process raft request' (duration: 683.354308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.712264Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.015509Z","time spent":"696.695098ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:18.712276Z","caller":"traceutil/trace.go:172","msg":"trace[430663270] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"681.803957ms","start":"2026-05-20T21:25:18.030448Z","end":"2026-05-20T21:25:18.712252Z","steps":["trace[430663270] 'process raft request' (duration: 681.522547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.712362Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.030425Z","time spent":"681.897107ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:25:18.712433Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.028552Z","time spent":"683.689098ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:25:18.711838Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"180.882359ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:18.712595Z","caller":"traceutil/trace.go:172","msg":"trace[144082866] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:509; }","duration":"181.626799ms","start":"2026-05-20T21:25:18.530937Z","end":"2026-05-20T21:25:18.712564Z","steps":["trace[144082866] 'agreement among raft nodes before linearized reading' (duration: 180.718549ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:18.712934Z","caller":"traceutil/trace.go:172","msg":"trace[864659458] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"676.664264ms","start":"2026-05-20T21:25:18.036258Z","end":"2026-05-20T21:25:18.712922Z","steps":["trace[864659458] 'process raft request' (duration: 676.547163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.712991Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.036247Z","time spent":"676.722294ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:18.713058Z","caller":"traceutil/trace.go:172","msg":"trace[620844275] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"668.573368ms","start":"2026-05-20T21:25:18.044472Z","end":"2026-05-20T21:25:18.713045Z","steps":["trace[620844275] 'process raft request' (duration: 668.384607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.713291Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.044450Z","time spent":"668.677688ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:18.713285Z","caller":"traceutil/trace.go:172","msg":"trace[1418359856] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"664.782715ms","start":"2026-05-20T21:25:18.048465Z","end":"2026-05-20T21:25:18.713248Z","steps":["trace[1418359856] 'process raft request' (duration: 664.459965ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.713418Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.048448Z","time spent":"664.907025ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:18.713726Z","caller":"traceutil/trace.go:172","msg":"trace[1533798328] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"665.200195ms","start":"2026-05-20T21:25:18.048517Z","end":"2026-05-20T21:25:18.713717Z","steps":["trace[1533798328] 'process raft request' (duration: 664.466585ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.713767Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.048512Z","time spent":"665.236985ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:18.713860Z","caller":"traceutil/trace.go:172","msg":"trace[1905375357] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"650.941245ms","start":"2026-05-20T21:25:18.062911Z","end":"2026-05-20T21:25:18.713853Z","steps":["trace[1905375357] 'process raft request' (duration: 650.672585ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.713896Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.062892Z","time spent":"650.988055ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:18.713966Z","caller":"traceutil/trace.go:172","msg":"trace[1946757027] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"647.914533ms","start":"2026-05-20T21:25:18.066042Z","end":"2026-05-20T21:25:18.713957Z","steps":["trace[1946757027] 'process raft request' (duration: 647.670903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.713994Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.066034Z","time spent":"647.948603ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:18.714280Z","caller":"traceutil/trace.go:172","msg":"trace[171260429] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"533.723151ms","start":"2026-05-20T21:25:18.180546Z","end":"2026-05-20T21:25:18.714269Z","steps":["trace[171260429] 'process raft request' (duration: 533.622091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.714365Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.180504Z","time spent":"533.817982ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:18.714405Z","caller":"traceutil/trace.go:172","msg":"trace[1401685537] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"621.074584ms","start":"2026-05-20T21:25:18.093317Z","end":"2026-05-20T21:25:18.714392Z","steps":["trace[1401685537] 'process raft request' (duration: 620.444323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:18.714473Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:18.093290Z","time spent":"621.157384ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:25:19.661344Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"130.487273ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:19.661439Z","caller":"traceutil/trace.go:172","msg":"trace[213468506] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:572; }","duration":"130.637443ms","start":"2026-05-20T21:25:19.530788Z","end":"2026-05-20T21:25:19.661426Z","steps":["trace[213468506] 'range keys from in-memory index tree' (duration: 130.465403ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:19.661567Z","caller":"traceutil/trace.go:172","msg":"trace[1110541901] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"312.899313ms","start":"2026-05-20T21:25:19.348653Z","end":"2026-05-20T21:25:19.661552Z","steps":["trace[1110541901] 'process raft request' (duration: 312.686983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:19.661751Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:19.348629Z","time spent":"312.986223ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20842,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:19.721762Z","caller":"traceutil/trace.go:172","msg":"trace[950771017] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"321.50871ms","start":"2026-05-20T21:25:19.400229Z","end":"2026-05-20T21:25:19.721738Z","steps":["trace[950771017] 'process raft request' (duration: 321.2746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:19.721886Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:19.400200Z","time spent":"321.63222ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:19.721993Z","caller":"traceutil/trace.go:172","msg":"trace[1671826820] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"346.670557ms","start":"2026-05-20T21:25:19.375308Z","end":"2026-05-20T21:25:19.721978Z","steps":["trace[1671826820] 'process raft request' (duration: 345.921597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:19.722119Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:19.375276Z","time spent":"346.778637ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:20.347623Z","caller":"traceutil/trace.go:172","msg":"trace[715377034] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:600; }","duration":"489.80081ms","start":"2026-05-20T21:25:19.857797Z","end":"2026-05-20T21:25:20.347597Z","steps":["trace[715377034] 'read index received' (duration: 489.78019ms)","trace[715377034] 'applied index is now lower than readState.Index' (duration: 19.29µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:20.444397Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"586.591779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:20.444465Z","caller":"traceutil/trace.go:172","msg":"trace[1433829981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"586.665099ms","start":"2026-05-20T21:25:19.857785Z","end":"2026-05-20T21:25:20.444450Z","steps":["trace[1433829981] 'agreement among raft nodes before linearized reading' (duration: 489.90295ms)","trace[1433829981] 'range keys from in-memory index tree' (duration: 96.664229ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:20.444492Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:19.857773Z","time spent":"586.713429ms","remote":"127.0.0.1:52820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T21:25:20.444662Z","caller":"traceutil/trace.go:172","msg":"trace[1294381838] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"683.020397ms","start":"2026-05-20T21:25:19.761620Z","end":"2026-05-20T21:25:20.444640Z","steps":["trace[1294381838] 'process raft request' (duration: 586.164688ms)","trace[1294381838] 'compare' (duration: 96.734539ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:20.444785Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:19.761597Z","time spent":"683.127468ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:20.468917Z","caller":"traceutil/trace.go:172","msg":"trace[528286822] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"568.244646ms","start":"2026-05-20T21:25:19.900649Z","end":"2026-05-20T21:25:20.468894Z","steps":["trace[528286822] 'process raft request' (duration: 568.033586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:20.469040Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:19.900614Z","time spent":"568.368046ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:20.469162Z","caller":"traceutil/trace.go:172","msg":"trace[91878706] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"630.899191ms","start":"2026-05-20T21:25:19.838252Z","end":"2026-05-20T21:25:20.469151Z","steps":["trace[91878706] 'process raft request' (duration: 630.27205ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:20.469196Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:19.838230Z","time spent":"630.951611ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:21.104023Z","caller":"traceutil/trace.go:172","msg":"trace[176891471] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:606; }","duration":"414.747956ms","start":"2026-05-20T21:25:20.689234Z","end":"2026-05-20T21:25:21.103982Z","steps":["trace[176891471] 'read index received' (duration: 414.601386ms)","trace[176891471] 'applied index is now lower than readState.Index' (duration: 144.45µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:21.108743Z","caller":"traceutil/trace.go:172","msg":"trace[124973873] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"458.378228ms","start":"2026-05-20T21:25:20.650349Z","end":"2026-05-20T21:25:21.108727Z","steps":["trace[124973873] 'process raft request' (duration: 457.500027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:21.108741Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"419.47987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" limit:1 ","response":"range_response_count:1 size:570096"} {"level":"info","ts":"2026-05-20T21:25:21.108821Z","caller":"traceutil/trace.go:172","msg":"trace[1275721746] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:582; }","duration":"419.57176ms","start":"2026-05-20T21:25:20.689229Z","end":"2026-05-20T21:25:21.108800Z","steps":["trace[1275721746] 'agreement among raft nodes before linearized reading' (duration: 415.173327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:21.108837Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:20.650321Z","time spent":"458.462038ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:25:21.108863Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:20.689202Z","time spent":"419.64987ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":570119,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:21.174586Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"135.263477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.103\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-20T21:25:21.174683Z","caller":"traceutil/trace.go:172","msg":"trace[1611251554] range","detail":"{range_begin:/registry/masterleases/199.19.213.103; range_end:; response_count:1; response_revision:583; }","duration":"135.374667ms","start":"2026-05-20T21:25:21.039295Z","end":"2026-05-20T21:25:21.174670Z","steps":["trace[1611251554] 'agreement among raft nodes before linearized reading' (duration: 135.101937ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:21.174980Z","caller":"traceutil/trace.go:172","msg":"trace[583423510] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"466.284743ms","start":"2026-05-20T21:25:20.708675Z","end":"2026-05-20T21:25:21.174960Z","steps":["trace[583423510] 'process raft request' (duration: 465.881533ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:21.175184Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:20.708648Z","time spent":"466.370213ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:25:21.175245Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"317.127986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:21.175185Z","caller":"traceutil/trace.go:172","msg":"trace[848067659] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"171.116742ms","start":"2026-05-20T21:25:21.004059Z","end":"2026-05-20T21:25:21.175176Z","steps":["trace[848067659] 'process raft request' (duration: 170.804122ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:21.175316Z","caller":"traceutil/trace.go:172","msg":"trace[1659610883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"317.209816ms","start":"2026-05-20T21:25:20.858093Z","end":"2026-05-20T21:25:21.175302Z","steps":["trace[1659610883] 'agreement among raft nodes before linearized reading' (duration: 317.063666ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:21.175343Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:20.858072Z","time spent":"317.266786ms","remote":"127.0.0.1:52820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T21:25:21.175480Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"431.054108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T21:25:21.175513Z","caller":"traceutil/trace.go:172","msg":"trace[1335377501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"431.086568ms","start":"2026-05-20T21:25:20.744419Z","end":"2026-05-20T21:25:21.175505Z","steps":["trace[1335377501] 'agreement among raft nodes before linearized reading' (duration: 431.011648ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:21.175603Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:20.744401Z","time spent":"431.194248ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:21.175626Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"453.498123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T21:25:21.175671Z","caller":"traceutil/trace.go:172","msg":"trace[965883196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"453.543903ms","start":"2026-05-20T21:25:20.722120Z","end":"2026-05-20T21:25:21.175664Z","steps":["trace[965883196] 'agreement among raft nodes before linearized reading' (duration: 453.440823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:21.175694Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:20.722084Z","time spent":"453.604113ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:21.296730Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.730773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" limit:1 ","response":"range_response_count:1 size:10870"} {"level":"info","ts":"2026-05-20T21:25:21.296802Z","caller":"traceutil/trace.go:172","msg":"trace[143883924] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:586; }","duration":"101.820143ms","start":"2026-05-20T21:25:21.194968Z","end":"2026-05-20T21:25:21.296788Z","steps":["trace[143883924] 'range keys from in-memory index tree' (duration: 95.945659ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:21.307637Z","caller":"traceutil/trace.go:172","msg":"trace[1440285270] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"125.41402ms","start":"2026-05-20T21:25:21.182206Z","end":"2026-05-20T21:25:21.307620Z","steps":["trace[1440285270] 'process raft request' (duration: 125.37101ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:21.307792Z","caller":"traceutil/trace.go:172","msg":"trace[934113798] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"127.283211ms","start":"2026-05-20T21:25:21.180493Z","end":"2026-05-20T21:25:21.307776Z","steps":["trace[934113798] 'process raft request' (duration: 126.938991ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:21.331976Z","caller":"traceutil/trace.go:172","msg":"trace[275104020] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"119.387585ms","start":"2026-05-20T21:25:21.212564Z","end":"2026-05-20T21:25:21.331951Z","steps":["trace[275104020] 'process raft request' (duration: 119.085145ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:21.332128Z","caller":"traceutil/trace.go:172","msg":"trace[1027784132] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"102.946583ms","start":"2026-05-20T21:25:21.229171Z","end":"2026-05-20T21:25:21.332118Z","steps":["trace[1027784132] 'process raft request' (duration: 102.604523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:25.361213Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654895747,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:25:25.861693Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654895747,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:25:26.362420Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654895747,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:25:26.860876Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.999831608s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-20T21:25:26.860988Z","caller":"traceutil/trace.go:172","msg":"trace[96932602] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999957048s","start":"2026-05-20T21:25:24.861005Z","end":"2026-05-20T21:25:26.860962Z","steps":["trace[96932602] 'agreement among raft nodes before linearized reading' (duration: 1.999828778s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:26.861061Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:24.860958Z","time spent":"2.000089728s","remote":"127.0.0.1:52834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/20 21:25:26 WARNING: [core] [Server #6]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-20T21:25:26.863237Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654895747,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:25:27.323028Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.790997979s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:27.323202Z","caller":"traceutil/trace.go:172","msg":"trace[569800342] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:609; }","duration":"1.791193339s","start":"2026-05-20T21:25:25.531983Z","end":"2026-05-20T21:25:27.323176Z","steps":["trace[569800342] 'range keys from in-memory index tree' (duration: 1.790920679s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:27.324772Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.495372952s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T21:25:27.325264Z","caller":"traceutil/trace.go:172","msg":"trace[1507730476] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:634; }","duration":"2.46420208s","start":"2026-05-20T21:25:24.861034Z","end":"2026-05-20T21:25:27.325236Z","steps":["trace[1507730476] 'read index received' (duration: 2.4641946s)","trace[1507730476] 'applied index is now lower than readState.Index' (duration: 5.91µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:27.326206Z","caller":"traceutil/trace.go:172","msg":"trace[1698395716] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"2.501707036s","start":"2026-05-20T21:25:24.824474Z","end":"2026-05-20T21:25:27.326181Z","steps":["trace[1698395716] 'process raft request' (duration: 2.501036786s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:27.326356Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:24.824444Z","time spent":"2.501835186s","remote":"127.0.0.1:53008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036189,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:27.697806Z","caller":"traceutil/trace.go:172","msg":"trace[1622824782] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:635; }","duration":"372.443786ms","start":"2026-05-20T21:25:27.325326Z","end":"2026-05-20T21:25:27.697769Z","steps":["trace[1622824782] 'read index received' (duration: 372.428406ms)","trace[1622824782] 'applied index is now lower than readState.Index' (duration: 13.74µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:28.086070Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"762.789965ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:28.086154Z","caller":"traceutil/trace.go:172","msg":"trace[1558701445] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:610; }","duration":"762.884525ms","start":"2026-05-20T21:25:27.323253Z","end":"2026-05-20T21:25:28.086137Z","steps":["trace[1558701445] 'agreement among raft nodes before linearized reading' (duration: 374.658648ms)","trace[1558701445] 'range keys from in-memory index tree' (duration: 388.111267ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:28.086254Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.497801234s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sp95v\" limit:1 ","response":"range_response_count:1 size:19040"} {"level":"info","ts":"2026-05-20T21:25:28.086322Z","caller":"traceutil/trace.go:172","msg":"trace[1627308240] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sp95v; range_end:; response_count:1; response_revision:610; }","duration":"2.497867874s","start":"2026-05-20T21:25:25.588438Z","end":"2026-05-20T21:25:28.086306Z","steps":["trace[1627308240] 'agreement among raft nodes before linearized reading' (duration: 2.109482097s)","trace[1627308240] 'range keys from in-memory index tree' (duration: 388.164207ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:28.086306Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"388.210967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-05-20T21:25:28.086359Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:25.588409Z","time spent":"2.497940944s","remote":"127.0.0.1:53196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":19063,"request content":"key:\"/registry/pods/kube-system/cilium-sp95v\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:28.086409Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.759396381s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T21:25:28.086482Z","caller":"traceutil/trace.go:172","msg":"trace[221393757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:610; }","duration":"2.759475211s","start":"2026-05-20T21:25:25.326987Z","end":"2026-05-20T21:25:28.086462Z","steps":["trace[221393757] 'agreement among raft nodes before linearized reading' (duration: 2.370908204s)","trace[221393757] 'range keys from in-memory index tree' (duration: 387.979617ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:28.086521Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:25.326962Z","time spent":"2.759550051s","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:28.086571Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.213814997s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:28.086615Z","caller":"traceutil/trace.go:172","msg":"trace[2042467656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"1.214621407s","start":"2026-05-20T21:25:26.871981Z","end":"2026-05-20T21:25:28.086602Z","steps":["trace[2042467656] 'agreement among raft nodes before linearized reading' (duration: 825.94308ms)","trace[2042467656] 'range keys from in-memory index tree' (duration: 387.818597ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:28.086771Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:26.871968Z","time spent":"1.214793668s","remote":"127.0.0.1:52820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T21:25:28.086785Z","caller":"traceutil/trace.go:172","msg":"trace[1539522854] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"2.900621482s","start":"2026-05-20T21:25:25.186144Z","end":"2026-05-20T21:25:28.086765Z","steps":["trace[1539522854] 'process raft request' (duration: 2.511835934s)","trace[1539522854] 'compare' (duration: 387.973717ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:28.086844Z","caller":"traceutil/trace.go:172","msg":"trace[434692982] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"2.343243894s","start":"2026-05-20T21:25:25.743586Z","end":"2026-05-20T21:25:28.086830Z","steps":["trace[434692982] 'process raft request' (duration: 2.342837713s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:28.086888Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:25.186085Z","time spent":"2.900730612s","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:25:28.086902Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:25.743556Z","time spent":"2.343316314s","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:28.086980Z","caller":"traceutil/trace.go:172","msg":"trace[835099541] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.221451583s","start":"2026-05-20T21:25:26.865519Z","end":"2026-05-20T21:25:28.086971Z","steps":["trace[835099541] 'process raft request' (duration: 1.221010412s)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:28.087008Z","caller":"traceutil/trace.go:172","msg":"trace[1993556029] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"702.044012ms","start":"2026-05-20T21:25:27.384833Z","end":"2026-05-20T21:25:28.086877Z","steps":["trace[1993556029] 'process raft request' (duration: 701.869922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:28.087022Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:26.865494Z","time spent":"1.221506273s","remote":"127.0.0.1:52990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":769,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:25:28.087979Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:27.384791Z","time spent":"702.243322ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:25:28.088424Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.75839314s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T21:25:28.088464Z","caller":"traceutil/trace.go:172","msg":"trace[1062164991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"2.75843594s","start":"2026-05-20T21:25:25.330017Z","end":"2026-05-20T21:25:28.088453Z","steps":["trace[1062164991] 'agreement among raft nodes before linearized reading' (duration: 2.367912321s)","trace[1062164991] 'range keys from in-memory index tree' (duration: 387.843037ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:28.088488Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:25.329983Z","time spent":"2.75849961s","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:28.589916Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654895756,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T21:25:28.857459Z","caller":"traceutil/trace.go:172","msg":"trace[1059297713] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:639; }","duration":"768.522489ms","start":"2026-05-20T21:25:28.088910Z","end":"2026-05-20T21:25:28.857432Z","steps":["trace[1059297713] 'read index received' (duration: 768.510609ms)","trace[1059297713] 'applied index is now lower than readState.Index' (duration: 10.18µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:29.357614Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654895760,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:25:29.946737Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"867.252879ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:29.947673Z","caller":"traceutil/trace.go:172","msg":"trace[343634837] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:614; }","duration":"868.17272ms","start":"2026-05-20T21:25:29.079459Z","end":"2026-05-20T21:25:29.947631Z","steps":["trace[343634837] 'range keys from in-memory index tree' (duration: 867.203899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:29.948582Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.858017357s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:29.948923Z","caller":"traceutil/trace.go:172","msg":"trace[1785304076] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:614; }","duration":"1.859995399s","start":"2026-05-20T21:25:28.088902Z","end":"2026-05-20T21:25:29.948897Z","steps":["trace[1785304076] 'agreement among raft nodes before linearized reading' (duration: 768.654349ms)","trace[1785304076] 'range keys from in-memory index tree' (duration: 1.089344828s)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:29.952126Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.094406632s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-20T21:25:29.952375Z","caller":"traceutil/trace.go:172","msg":"trace[395514522] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"1.094829112s","start":"2026-05-20T21:25:28.857523Z","end":"2026-05-20T21:25:29.952352Z","steps":["trace[395514522] 'read index received' (duration: 989.364487ms)","trace[395514522] 'applied index is now lower than readState.Index' (duration: 105.462535ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:29.952520Z","caller":"traceutil/trace.go:172","msg":"trace[1198814133] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.859720478s","start":"2026-05-20T21:25:28.092785Z","end":"2026-05-20T21:25:29.952505Z","steps":["trace[1198814133] 'process raft request' (duration: 1.859576178s)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:29.952535Z","caller":"traceutil/trace.go:172","msg":"trace[992758439] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.859927358s","start":"2026-05-20T21:25:28.092597Z","end":"2026-05-20T21:25:29.952524Z","steps":["trace[992758439] 'process raft request' (duration: 1.859654878s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:29.952625Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:28.092723Z","time spent":"1.859844638s","remote":"127.0.0.1:53332","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-05-20T21:25:29.952690Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.855710625s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:29.952725Z","caller":"traceutil/trace.go:172","msg":"trace[23873817] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:616; }","duration":"1.855749475s","start":"2026-05-20T21:25:28.096967Z","end":"2026-05-20T21:25:29.952717Z","steps":["trace[23873817] 'agreement among raft nodes before linearized reading' (duration: 1.855506395s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:29.952747Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:28.096953Z","time spent":"1.855788825s","remote":"127.0.0.1:53536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:29.952729Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"819.490565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:25:29.952793Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.211696445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:29.952807Z","caller":"traceutil/trace.go:172","msg":"trace[22911491] range","detail":"{range_begin:/registry/controllerrevisions; range_end:; response_count:0; response_revision:617; }","duration":"819.572375ms","start":"2026-05-20T21:25:29.133214Z","end":"2026-05-20T21:25:29.952787Z","steps":["trace[22911491] 'agreement among raft nodes before linearized reading' (duration: 819.462775ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:29.952837Z","caller":"traceutil/trace.go:172","msg":"trace[32167408] range","detail":"{range_begin:/registry/serviceaccounts; range_end:; response_count:0; response_revision:616; }","duration":"1.211852795s","start":"2026-05-20T21:25:28.740973Z","end":"2026-05-20T21:25:29.952826Z","steps":["trace[32167408] 'agreement among raft nodes before linearized reading' (duration: 1.211482495s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:29.952860Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:28.740942Z","time spent":"1.211912575s","remote":"127.0.0.1:53248","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":"info","ts":"2026-05-20T21:25:29.953004Z","caller":"traceutil/trace.go:172","msg":"trace[1057805068] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"1.851900183s","start":"2026-05-20T21:25:28.101094Z","end":"2026-05-20T21:25:29.952994Z","steps":["trace[1057805068] 'process raft request' (duration: 1.851315322s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:29.953013Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"240.808342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:29.953050Z","caller":"traceutil/trace.go:172","msg":"trace[1505042155] range","detail":"{range_begin:/registry/podtemplates; range_end:; response_count:0; response_revision:617; }","duration":"240.850452ms","start":"2026-05-20T21:25:29.712191Z","end":"2026-05-20T21:25:29.953042Z","steps":["trace[1505042155] 'agreement among raft nodes before linearized reading' (duration: 240.786211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:29.953057Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:28.101065Z","time spent":"1.851968033s","remote":"127.0.0.1:53196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19197,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:25:29.952855Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:29.133186Z","time spent":"819.655375ms","remote":"127.0.0.1:53750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":33,"response count":0,"response size":28,"request content":"key:\"/registry/controllerrevisions\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:29.953092Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"409.057983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:29.953123Z","caller":"traceutil/trace.go:172","msg":"trace[1102633369] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions; range_end:; response_count:0; response_revision:617; }","duration":"409.087043ms","start":"2026-05-20T21:25:29.544030Z","end":"2026-05-20T21:25:29.953117Z","steps":["trace[1102633369] 'agreement among raft nodes before linearized reading' (duration: 409.049753ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:29.953137Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:29.544006Z","time spent":"409.126913ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:29.953050Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.863209081s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:29.953176Z","caller":"traceutil/trace.go:172","msg":"trace[57256470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"1.863335221s","start":"2026-05-20T21:25:28.089835Z","end":"2026-05-20T21:25:29.953170Z","steps":["trace[57256470] 'agreement among raft nodes before linearized reading' (duration: 1.86265919s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:29.953196Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:28.089814Z","time spent":"1.863378121s","remote":"127.0.0.1:52834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T21:25:29.953068Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"327.569894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:29.953323Z","caller":"traceutil/trace.go:172","msg":"trace[1457024528] range","detail":"{range_begin:/registry/clusterroles; range_end:; response_count:0; response_revision:617; }","duration":"327.817644ms","start":"2026-05-20T21:25:29.625492Z","end":"2026-05-20T21:25:29.953309Z","steps":["trace[1457024528] 'agreement among raft nodes before linearized reading' (duration: 327.555574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:29.953374Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:29.625468Z","time spent":"327.891274ms","remote":"127.0.0.1:53536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:29.953386Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.121092131s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:29.953447Z","caller":"traceutil/trace.go:172","msg":"trace[2091618719] range","detail":"{range_begin:/registry/minions; range_end:; response_count:0; response_revision:616; }","duration":"1.121151501s","start":"2026-05-20T21:25:28.832290Z","end":"2026-05-20T21:25:29.953441Z","steps":["trace[2091618719] 'agreement among raft nodes before linearized reading' (duration: 1.12021904s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:29.953467Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:28.832269Z","time spent":"1.121192561s","remote":"127.0.0.1:53180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":28,"request content":"key:\"/registry/minions\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:29.954597Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:28.092571Z","time spent":"1.860001148s","remote":"127.0.0.1:53332","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-05-20T21:25:32.732862Z","caller":"traceutil/trace.go:172","msg":"trace[1537666454] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:668; }","duration":"281.886881ms","start":"2026-05-20T21:25:32.450940Z","end":"2026-05-20T21:25:32.732827Z","steps":["trace[1537666454] 'read index received' (duration: 281.876031ms)","trace[1537666454] 'applied index is now lower than readState.Index' (duration: 9.33µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:32.733031Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"282.066521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/servicecidrs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:32.734061Z","caller":"traceutil/trace.go:172","msg":"trace[1368340793] range","detail":"{range_begin:/registry/servicecidrs; range_end:; response_count:0; response_revision:640; }","duration":"283.107422ms","start":"2026-05-20T21:25:32.450934Z","end":"2026-05-20T21:25:32.734042Z","steps":["trace[1368340793] 'agreement among raft nodes before linearized reading' (duration: 282.017331ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:32.733161Z","caller":"traceutil/trace.go:172","msg":"trace[256402522] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"770.25223ms","start":"2026-05-20T21:25:31.962892Z","end":"2026-05-20T21:25:32.733144Z","steps":["trace[256402522] 'process raft request' (duration: 770.18213ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:32.733216Z","caller":"traceutil/trace.go:172","msg":"trace[257591643] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"770.28113ms","start":"2026-05-20T21:25:31.962892Z","end":"2026-05-20T21:25:32.733173Z","steps":["trace[257591643] 'process raft request' (duration: 770.05021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:32.734391Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:31.962864Z","time spent":"771.441121ms","remote":"127.0.0.1:53332","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-05-20T21:25:32.734538Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:31.962864Z","time spent":"771.563381ms","remote":"127.0.0.1:53332","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-05-20T21:25:32.958363Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"427.057365ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:25:32.958422Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"341.468394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sp95v\" limit:1 ","response":"range_response_count:1 size:19576"} {"level":"info","ts":"2026-05-20T21:25:32.958521Z","caller":"traceutil/trace.go:172","msg":"trace[465395360] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sp95v; range_end:; response_count:1; response_revision:642; }","duration":"341.571684ms","start":"2026-05-20T21:25:32.616918Z","end":"2026-05-20T21:25:32.958489Z","steps":["trace[465395360] 'agreement among raft nodes before linearized reading' (duration: 341.316024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:32.958585Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:32.616888Z","time spent":"341.683094ms","remote":"127.0.0.1:53196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":19599,"request content":"key:\"/registry/pods/kube-system/cilium-sp95v\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:32.958601Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"505.608731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:32.958635Z","caller":"traceutil/trace.go:172","msg":"trace[1417697267] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations; range_end:; response_count:0; response_revision:642; }","duration":"505.643121ms","start":"2026-05-20T21:25:32.452983Z","end":"2026-05-20T21:25:32.958626Z","steps":["trace[1417697267] 'agreement among raft nodes before linearized reading' (duration: 505.584991ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:32.958450Z","caller":"traceutil/trace.go:172","msg":"trace[181726587] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:642; }","duration":"427.162585ms","start":"2026-05-20T21:25:32.531269Z","end":"2026-05-20T21:25:32.958432Z","steps":["trace[181726587] 'agreement among raft nodes before linearized reading' (duration: 427.004205ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:32.958670Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:32.452972Z","time spent":"505.690001ms","remote":"127.0.0.1:53780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 "} {"level":"info","ts":"2026-05-20T21:25:32.958895Z","caller":"traceutil/trace.go:172","msg":"trace[2108123718] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:670; }","duration":"224.32397ms","start":"2026-05-20T21:25:32.733875Z","end":"2026-05-20T21:25:32.958199Z","steps":["trace[2108123718] 'read index received' (duration: 224.30888ms)","trace[2108123718] 'applied index is now lower than readState.Index' (duration: 13.22µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:32.959206Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"341.659254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-operator-6c7f5cd974-bt4sk.18b163236db4a36e\" limit:1 ","response":"range_response_count:1 size:865"} {"level":"info","ts":"2026-05-20T21:25:32.959269Z","caller":"traceutil/trace.go:172","msg":"trace[1371753647] range","detail":"{range_begin:/registry/events/kube-system/cilium-operator-6c7f5cd974-bt4sk.18b163236db4a36e; range_end:; response_count:1; response_revision:642; }","duration":"341.735024ms","start":"2026-05-20T21:25:32.617515Z","end":"2026-05-20T21:25:32.959250Z","steps":["trace[1371753647] 'agreement among raft nodes before linearized reading' (duration: 340.712513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:32.959314Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:32.617495Z","time spent":"341.807734ms","remote":"127.0.0.1:52990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":888,"request content":"key:\"/registry/events/kube-system/cilium-operator-6c7f5cd974-bt4sk.18b163236db4a36e\" limit:1 "} {"level":"info","ts":"2026-05-20T21:25:32.959660Z","caller":"traceutil/trace.go:172","msg":"trace[1467058086] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"962.927998ms","start":"2026-05-20T21:25:31.996716Z","end":"2026-05-20T21:25:32.959644Z","steps":["trace[1467058086] 'process raft request' (duration: 961.693817ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:32.959730Z","caller":"traceutil/trace.go:172","msg":"trace[603642874] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"858.939073ms","start":"2026-05-20T21:25:32.100775Z","end":"2026-05-20T21:25:32.959714Z","steps":["trace[603642874] 'process raft request' (duration: 858.815483ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:32.959759Z","caller":"traceutil/trace.go:172","msg":"trace[2030656259] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"857.154762ms","start":"2026-05-20T21:25:32.102581Z","end":"2026-05-20T21:25:32.959736Z","steps":["trace[2030656259] 'process raft request' (duration: 857.062422ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:32.960365Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:32.102567Z","time spent":"857.714132ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:25:32.961033Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:31.996681Z","time spent":"963.024708ms","remote":"127.0.0.1:53008","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-05-20T21:25:32.961601Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:32.100747Z","time spent":"859.025094ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:33.457365Z","caller":"traceutil/trace.go:172","msg":"trace[224243878] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"489.778069ms","start":"2026-05-20T21:25:32.967548Z","end":"2026-05-20T21:25:33.457326Z","steps":["trace[224243878] 'process raft request' (duration: 422.921832ms)","trace[224243878] 'compare' (duration: 66.720877ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:33.457668Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:32.967535Z","time spent":"489.906139ms","remote":"127.0.0.1:52990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":850,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:33.673652Z","caller":"traceutil/trace.go:172","msg":"trace[402809067] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:674; }","duration":"142.056982ms","start":"2026-05-20T21:25:33.531569Z","end":"2026-05-20T21:25:33.673626Z","steps":["trace[402809067] 'read index received' (duration: 142.047832ms)","trace[402809067] 'applied index is now lower than readState.Index' (duration: 7.79µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:33.745286Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"213.688523ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:33.745341Z","caller":"traceutil/trace.go:172","msg":"trace[1493132955] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"722.151446ms","start":"2026-05-20T21:25:33.023162Z","end":"2026-05-20T21:25:33.745314Z","steps":["trace[1493132955] 'process raft request' (duration: 722.100576ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:33.745397Z","caller":"traceutil/trace.go:172","msg":"trace[1787444229] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:646; }","duration":"213.812423ms","start":"2026-05-20T21:25:33.531561Z","end":"2026-05-20T21:25:33.745373Z","steps":["trace[1787444229] 'agreement among raft nodes before linearized reading' (duration: 142.205512ms)","trace[1787444229] 'range keys from in-memory index tree' (duration: 71.453731ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:33.745460Z","caller":"traceutil/trace.go:172","msg":"trace[1677934766] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"770.88636ms","start":"2026-05-20T21:25:32.974439Z","end":"2026-05-20T21:25:33.745325Z","steps":["trace[1677934766] 'process raft request' (duration: 699.347299ms)","trace[1677934766] 'compare' (duration: 71.361311ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:33.745597Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:32.974418Z","time spent":"771.11741ms","remote":"127.0.0.1:53196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19734,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:25:33.745722Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:33.023133Z","time spent":"722.517496ms","remote":"127.0.0.1:53284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2676,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:33.897418Z","caller":"traceutil/trace.go:172","msg":"trace[1118788093] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:676; }","duration":"223.64565ms","start":"2026-05-20T21:25:33.673740Z","end":"2026-05-20T21:25:33.897386Z","steps":["trace[1118788093] 'read index received' (duration: 223.63528ms)","trace[1118788093] 'applied index is now lower than readState.Index' (duration: 9.39µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:34.107625Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"511.941526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:34.107720Z","caller":"traceutil/trace.go:172","msg":"trace[393198104] range","detail":"{range_begin:/registry/csinodes; range_end:; response_count:0; response_revision:648; }","duration":"512.037386ms","start":"2026-05-20T21:25:33.595652Z","end":"2026-05-20T21:25:34.107690Z","steps":["trace[393198104] 'agreement among raft nodes before linearized reading' (duration: 301.832486ms)","trace[393198104] 'range keys from in-memory index tree' (duration: 210.07613ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:34.107755Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"210.2976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-05-20T21:25:34.107763Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:33.595631Z","time spent":"512.121636ms","remote":"127.0.0.1:53640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":22,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes\" limit:1 "} {"level":"info","ts":"2026-05-20T21:25:34.107947Z","caller":"traceutil/trace.go:172","msg":"trace[1216513114] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"577.132902ms","start":"2026-05-20T21:25:33.530789Z","end":"2026-05-20T21:25:34.107921Z","steps":["trace[1216513114] 'process raft request' (duration: 366.604672ms)","trace[1216513114] 'compare' (duration: 210.07676ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:34.108188Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:33.530765Z","time spent":"577.277782ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:34.108345Z","caller":"traceutil/trace.go:172","msg":"trace[120736174] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:676; }","duration":"210.8114ms","start":"2026-05-20T21:25:33.897503Z","end":"2026-05-20T21:25:34.108315Z","steps":["trace[120736174] 'read index received' (duration: 34.72µs)","trace[120736174] 'applied index is now lower than readState.Index' (duration: 210.77552ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:34.108363Z","caller":"traceutil/trace.go:172","msg":"trace[1436620935] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"482.719664ms","start":"2026-05-20T21:25:33.625609Z","end":"2026-05-20T21:25:34.108328Z","steps":["trace[1436620935] 'process raft request' (duration: 482.322054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:34.108510Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:33.625588Z","time spent":"482.856234ms","remote":"127.0.0.1:52990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":747,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T21:25:34.108521Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"357.660486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sp95v\" limit:1 ","response":"range_response_count:1 size:19749"} {"level":"warn","ts":"2026-05-20T21:25:34.108565Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"135.539387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:34.108572Z","caller":"traceutil/trace.go:172","msg":"trace[1884122480] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sp95v; range_end:; response_count:1; response_revision:651; }","duration":"357.714816ms","start":"2026-05-20T21:25:33.750844Z","end":"2026-05-20T21:25:34.108559Z","steps":["trace[1884122480] 'agreement among raft nodes before linearized reading' (duration: 357.537605ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:34.108598Z","caller":"traceutil/trace.go:172","msg":"trace[1428601938] range","detail":"{range_begin:/registry/daemonsets; range_end:; response_count:0; response_revision:651; }","duration":"135.570407ms","start":"2026-05-20T21:25:33.973019Z","end":"2026-05-20T21:25:34.108589Z","steps":["trace[1428601938] 'agreement among raft nodes before linearized reading' (duration: 135.526467ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:34.108605Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:33.750830Z","time spent":"357.766826ms","remote":"127.0.0.1:53196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":19772,"request content":"key:\"/registry/pods/kube-system/cilium-sp95v\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:34.108520Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"358.518147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" limit:1 ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-20T21:25:34.108669Z","caller":"traceutil/trace.go:172","msg":"trace[1366456898] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:651; }","duration":"358.660747ms","start":"2026-05-20T21:25:33.749987Z","end":"2026-05-20T21:25:34.108648Z","steps":["trace[1366456898] 'agreement among raft nodes before linearized reading' (duration: 358.446216ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:34.108654Z","caller":"traceutil/trace.go:172","msg":"trace[1263357246] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"566.379755ms","start":"2026-05-20T21:25:33.542230Z","end":"2026-05-20T21:25:34.108609Z","steps":["trace[1263357246] 'process raft request' (duration: 565.593504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:34.108754Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:33.749961Z","time spent":"358.764857ms","remote":"127.0.0.1:53248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:34.108826Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:33.542205Z","time spent":"566.542105ms","remote":"127.0.0.1:53180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4175,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:25:34.437169Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"149.037146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:25:34.437295Z","caller":"traceutil/trace.go:172","msg":"trace[802223444] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"316.938926ms","start":"2026-05-20T21:25:34.120333Z","end":"2026-05-20T21:25:34.437272Z","steps":["trace[802223444] 'process raft request' (duration: 167.68308ms)","trace[802223444] 'compare' (duration: 148.787066ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:34.437370Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:34.120304Z","time spent":"317.032706ms","remote":"127.0.0.1:53196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2738,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T21:25:34.490202Z","caller":"traceutil/trace.go:172","msg":"trace[701684565] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"366.932502ms","start":"2026-05-20T21:25:34.123252Z","end":"2026-05-20T21:25:34.490185Z","steps":["trace[701684565] 'process raft request' (duration: 366.795272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:34.490317Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:34.123221Z","time spent":"367.041162ms","remote":"127.0.0.1:53196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19816,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:34.645386Z","caller":"traceutil/trace.go:172","msg":"trace[1354567649] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:681; }","duration":"113.715321ms","start":"2026-05-20T21:25:34.531633Z","end":"2026-05-20T21:25:34.645349Z","steps":["trace[1354567649] 'read index received' (duration: 113.686011ms)","trace[1354567649] 'applied index is now lower than readState.Index' (duration: 27.08µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:34.666350Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"134.693516ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:34.666449Z","caller":"traceutil/trace.go:172","msg":"trace[1662499026] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:653; }","duration":"134.797306ms","start":"2026-05-20T21:25:34.531624Z","end":"2026-05-20T21:25:34.666421Z","steps":["trace[1662499026] 'agreement among raft nodes before linearized reading' (duration: 113.869821ms)","trace[1662499026] 'range keys from in-memory index tree' (duration: 20.798135ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:34.666612Z","caller":"traceutil/trace.go:172","msg":"trace[654393576] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"221.663608ms","start":"2026-05-20T21:25:34.444925Z","end":"2026-05-20T21:25:34.666589Z","steps":["trace[654393576] 'process raft request' (duration: 221.553698ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:34.666813Z","caller":"traceutil/trace.go:172","msg":"trace[2014650949] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"223.277999ms","start":"2026-05-20T21:25:34.443479Z","end":"2026-05-20T21:25:34.666757Z","steps":["trace[2014650949] 'process raft request' (duration: 222.879019ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:34.666817Z","caller":"traceutil/trace.go:172","msg":"trace[908953032] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"224.58355ms","start":"2026-05-20T21:25:34.442179Z","end":"2026-05-20T21:25:34.666763Z","steps":["trace[908953032] 'process raft request' (duration: 203.196265ms)","trace[908953032] 'compare' (duration: 20.793535ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:34.666839Z","caller":"traceutil/trace.go:172","msg":"trace[1485282096] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"222.562159ms","start":"2026-05-20T21:25:34.444248Z","end":"2026-05-20T21:25:34.666811Z","steps":["trace[1485282096] 'process raft request' (duration: 222.155119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:36.460635Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40944","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:36.503490Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40952","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:36.558432Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40966","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:36.578305Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40992","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:36.599946Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41008","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:36.609855Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41020","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:36.629793Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41032","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:36.659654Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41046","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:36.700474Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41070","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:36.722969Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41076","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:36.863063Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41112","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:37.000452Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41128","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:37.015301Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41136","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-20T21:25:37.035583Z","caller":"traceutil/trace.go:172","msg":"trace[139683232] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"195.408319ms","start":"2026-05-20T21:25:36.840153Z","end":"2026-05-20T21:25:37.035561Z","steps":["trace[139683232] 'process raft request' (duration: 195.214739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:37.035913Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"178.160177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:37.035967Z","caller":"traceutil/trace.go:172","msg":"trace[873714376] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"178.233567ms","start":"2026-05-20T21:25:36.857722Z","end":"2026-05-20T21:25:37.035955Z","steps":["trace[873714376] 'agreement among raft nodes before linearized reading' (duration: 178.112927ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:37.035781Z","caller":"traceutil/trace.go:172","msg":"trace[817057467] linearizableReadLoop","detail":"{readStateIndex:705; appliedIndex:705; }","duration":"177.799657ms","start":"2026-05-20T21:25:36.857726Z","end":"2026-05-20T21:25:37.035525Z","steps":["trace[817057467] 'read index received' (duration: 177.641357ms)","trace[817057467] 'applied index is now lower than readState.Index' (duration: 157.14µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:37.036091Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41152","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:37.057823Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"186.212063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:37.057891Z","caller":"traceutil/trace.go:172","msg":"trace[234092601] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:681; }","duration":"186.300323ms","start":"2026-05-20T21:25:36.871577Z","end":"2026-05-20T21:25:37.057877Z","steps":["trace[234092601] 'agreement among raft nodes before linearized reading' (duration: 186.174293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:37.058036Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"186.356273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:37.058120Z","caller":"traceutil/trace.go:172","msg":"trace[1193424422] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies; range_end:; response_count:0; response_revision:681; }","duration":"186.431283ms","start":"2026-05-20T21:25:36.871652Z","end":"2026-05-20T21:25:37.058084Z","steps":["trace[1193424422] 'agreement among raft nodes before linearized reading' (duration: 186.317463ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:37.058246Z","caller":"traceutil/trace.go:172","msg":"trace[37333270] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"171.115072ms","start":"2026-05-20T21:25:36.887121Z","end":"2026-05-20T21:25:37.058236Z","steps":["trace[37333270] 'process raft request' (duration: 170.268852ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:37.058400Z","caller":"traceutil/trace.go:172","msg":"trace[1502150618] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"216.589814ms","start":"2026-05-20T21:25:36.841790Z","end":"2026-05-20T21:25:37.058380Z","steps":["trace[1502150618] 'process raft request' (duration: 215.454764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:37.076163Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41158","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:37.091584Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41180","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:37.115586Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41206","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:37.136644Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41236","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:37.157272Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41252","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:37.189479Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41272","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:38.513962Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41308","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-20T21:25:38.817977Z","caller":"traceutil/trace.go:172","msg":"trace[600917775] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:746; }","duration":"152.284529ms","start":"2026-05-20T21:25:38.665658Z","end":"2026-05-20T21:25:38.817942Z","steps":["trace[600917775] 'read index received' (duration: 152.274739ms)","trace[600917775] 'applied index is now lower than readState.Index' (duration: 7.63µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:38.818238Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"152.557949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sp95v\" limit:1 ","response":"range_response_count:1 size:20590"} {"level":"info","ts":"2026-05-20T21:25:38.818309Z","caller":"traceutil/trace.go:172","msg":"trace[1237656075] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sp95v; range_end:; response_count:1; response_revision:717; }","duration":"152.645999ms","start":"2026-05-20T21:25:38.665647Z","end":"2026-05-20T21:25:38.818293Z","steps":["trace[1237656075] 'agreement among raft nodes before linearized reading' (duration: 152.395789ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:38.818608Z","caller":"traceutil/trace.go:172","msg":"trace[324283198] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"270.058733ms","start":"2026-05-20T21:25:38.548504Z","end":"2026-05-20T21:25:38.818562Z","steps":["trace[324283198] 'process raft request' (duration: 269.474632ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:38.861275Z","caller":"traceutil/trace.go:172","msg":"trace[1552133372] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"260.841696ms","start":"2026-05-20T21:25:38.600405Z","end":"2026-05-20T21:25:38.861247Z","steps":["trace[1552133372] 'process raft request' (duration: 260.323336ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:38.861285Z","caller":"traceutil/trace.go:172","msg":"trace[853764288] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"130.888753ms","start":"2026-05-20T21:25:38.730377Z","end":"2026-05-20T21:25:38.861265Z","steps":["trace[853764288] 'process raft request' (duration: 130.803473ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:41.400898Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41328","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:41.418649Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41354","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:41.518625Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41370","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:41.543529Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41400","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:41.704680Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41420","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:25:42.130622Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41428","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-20T21:25:44.388768Z","caller":"traceutil/trace.go:172","msg":"trace[575705113] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"258.912105ms","start":"2026-05-20T21:25:44.129837Z","end":"2026-05-20T21:25:44.388749Z","steps":["trace[575705113] 'process raft request' (duration: 258.799485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:44.626769Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"127.144791ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:25:44.626884Z","caller":"traceutil/trace.go:172","msg":"trace[1083708069] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"220.329887ms","start":"2026-05-20T21:25:44.406534Z","end":"2026-05-20T21:25:44.626864Z","steps":["trace[1083708069] 'process raft request' (duration: 92.983826ms)","trace[1083708069] 'compare' (duration: 126.885721ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:44.628169Z","caller":"traceutil/trace.go:172","msg":"trace[336774967] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:794; }","duration":"106.197046ms","start":"2026-05-20T21:25:44.521952Z","end":"2026-05-20T21:25:44.628149Z","steps":["trace[336774967] 'read index received' (duration: 106.190786ms)","trace[336774967] 'applied index is now lower than readState.Index' (duration: 5.18µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:44.628327Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.368006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:44.628374Z","caller":"traceutil/trace.go:172","msg":"trace[540662436] range","detail":"{range_begin:/registry/statefulsets; range_end:; response_count:0; response_revision:763; }","duration":"106.419606ms","start":"2026-05-20T21:25:44.521943Z","end":"2026-05-20T21:25:44.628363Z","steps":["trace[540662436] 'agreement among raft nodes before linearized reading' (duration: 106.337366ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:44.628743Z","caller":"traceutil/trace.go:172","msg":"trace[457601284] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"185.457842ms","start":"2026-05-20T21:25:44.443270Z","end":"2026-05-20T21:25:44.628727Z","steps":["trace[457601284] 'process raft request' (duration: 185.051632ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:45.410492Z","caller":"traceutil/trace.go:172","msg":"trace[596516785] linearizableReadLoop","detail":"{readStateIndex:795; appliedIndex:795; }","duration":"256.898944ms","start":"2026-05-20T21:25:45.153567Z","end":"2026-05-20T21:25:45.410466Z","steps":["trace[596516785] 'read index received' (duration: 256.889824ms)","trace[596516785] 'applied index is now lower than readState.Index' (duration: 7.04µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:45.410726Z","caller":"traceutil/trace.go:172","msg":"trace[1470624527] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"289.640817ms","start":"2026-05-20T21:25:45.121068Z","end":"2026-05-20T21:25:45.410709Z","steps":["trace[1470624527] 'process raft request' (duration: 289.516147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:45.410878Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"257.291984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T21:25:45.410926Z","caller":"traceutil/trace.go:172","msg":"trace[1679693322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:764; }","duration":"257.353364ms","start":"2026-05-20T21:25:45.153562Z","end":"2026-05-20T21:25:45.410916Z","steps":["trace[1679693322] 'agreement among raft nodes before linearized reading' (duration: 257.004464ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:45.433948Z","caller":"traceutil/trace.go:172","msg":"trace[1399101220] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"279.421259ms","start":"2026-05-20T21:25:45.154508Z","end":"2026-05-20T21:25:45.433929Z","steps":["trace[1399101220] 'process raft request' (duration: 279.389159ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:45.434296Z","caller":"traceutil/trace.go:172","msg":"trace[780029505] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"280.602691ms","start":"2026-05-20T21:25:45.153683Z","end":"2026-05-20T21:25:45.434286Z","steps":["trace[780029505] 'process raft request' (duration: 280.12684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:45.645737Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"114.493102ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:45.645837Z","caller":"traceutil/trace.go:172","msg":"trace[576437192] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:767; }","duration":"114.602222ms","start":"2026-05-20T21:25:45.531210Z","end":"2026-05-20T21:25:45.645812Z","steps":["trace[576437192] 'agreement among raft nodes before linearized reading' (duration: 60.793403ms)","trace[576437192] 'range keys from in-memory index tree' (duration: 53.671379ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:45.646449Z","caller":"traceutil/trace.go:172","msg":"trace[1259995950] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"229.932694ms","start":"2026-05-20T21:25:45.416491Z","end":"2026-05-20T21:25:45.646423Z","steps":["trace[1259995950] 'process raft request' (duration: 175.446705ms)","trace[1259995950] 'compare' (duration: 54.011439ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:46.014083Z","caller":"traceutil/trace.go:172","msg":"trace[1001329067] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:799; }","duration":"121.616977ms","start":"2026-05-20T21:25:45.892439Z","end":"2026-05-20T21:25:46.014056Z","steps":["trace[1001329067] 'read index received' (duration: 121.605747ms)","trace[1001329067] 'applied index is now lower than readState.Index' (duration: 9.23µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:46.014268Z","caller":"traceutil/trace.go:172","msg":"trace[1742734934] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"171.698423ms","start":"2026-05-20T21:25:45.842550Z","end":"2026-05-20T21:25:46.014248Z","steps":["trace[1742734934] 'process raft request' (duration: 171.539983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:46.014300Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"121.831037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:46.014573Z","caller":"traceutil/trace.go:172","msg":"trace[1437618000] range","detail":"{range_begin:/registry/resourceslices; range_end:; response_count:0; response_revision:768; }","duration":"122.125447ms","start":"2026-05-20T21:25:45.892434Z","end":"2026-05-20T21:25:46.014559Z","steps":["trace[1437618000] 'agreement among raft nodes before linearized reading' (duration: 121.706387ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:46.230175Z","caller":"traceutil/trace.go:172","msg":"trace[1255308421] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:802; }","duration":"100.411962ms","start":"2026-05-20T21:25:46.129727Z","end":"2026-05-20T21:25:46.230139Z","steps":["trace[1255308421] 'read index received' (duration: 100.403132ms)","trace[1255308421] 'applied index is now lower than readState.Index' (duration: 7.3µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:46.231980Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"102.240253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sp95v\" limit:1 ","response":"range_response_count:1 size:20776"} {"level":"info","ts":"2026-05-20T21:25:46.232077Z","caller":"traceutil/trace.go:172","msg":"trace[645611010] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sp95v; range_end:; response_count:1; response_revision:771; }","duration":"102.347444ms","start":"2026-05-20T21:25:46.129715Z","end":"2026-05-20T21:25:46.232063Z","steps":["trace[645611010] 'agreement among raft nodes before linearized reading' (duration: 100.523572ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:46.232914Z","caller":"traceutil/trace.go:172","msg":"trace[1230057801] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"187.094014ms","start":"2026-05-20T21:25:46.045800Z","end":"2026-05-20T21:25:46.232894Z","steps":["trace[1230057801] 'process raft request' (duration: 184.386742ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:46.479744Z","caller":"traceutil/trace.go:172","msg":"trace[1533281241] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"232.303326ms","start":"2026-05-20T21:25:46.247416Z","end":"2026-05-20T21:25:46.479720Z","steps":["trace[1533281241] 'process raft request' (duration: 232.168126ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:47.285637Z","caller":"traceutil/trace.go:172","msg":"trace[1542158063] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:806; }","duration":"425.802214ms","start":"2026-05-20T21:25:46.859807Z","end":"2026-05-20T21:25:47.285609Z","steps":["trace[1542158063] 'read index received' (duration: 425.792754ms)","trace[1542158063] 'applied index is now lower than readState.Index' (duration: 7.99µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:47.310462Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"450.645802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:47.310517Z","caller":"traceutil/trace.go:172","msg":"trace[1201253772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:774; }","duration":"450.712202ms","start":"2026-05-20T21:25:46.859792Z","end":"2026-05-20T21:25:47.310504Z","steps":["trace[1201253772] 'agreement among raft nodes before linearized reading' (duration: 425.903294ms)","trace[1201253772] 'range keys from in-memory index tree' (duration: 24.701838ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:47.310545Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:46.859771Z","time spent":"450.767922ms","remote":"127.0.0.1:52820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T21:25:47.310782Z","caller":"traceutil/trace.go:172","msg":"trace[2049279608] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"594.306765ms","start":"2026-05-20T21:25:46.716445Z","end":"2026-05-20T21:25:47.310752Z","steps":["trace[2049279608] 'process raft request' (duration: 569.218927ms)","trace[2049279608] 'compare' (duration: 24.701828ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:47.310918Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:46.716431Z","time spent":"594.424205ms","remote":"127.0.0.1:53196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20573,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:47.446613Z","caller":"traceutil/trace.go:172","msg":"trace[753731862] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:807; }","duration":"123.339758ms","start":"2026-05-20T21:25:47.323253Z","end":"2026-05-20T21:25:47.446592Z","steps":["trace[753731862] 'read index received' (duration: 123.333338ms)","trace[753731862] 'applied index is now lower than readState.Index' (duration: 5.34µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:47.524788Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"201.513064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:47.525087Z","caller":"traceutil/trace.go:172","msg":"trace[1643146123] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"202.486275ms","start":"2026-05-20T21:25:47.322542Z","end":"2026-05-20T21:25:47.525028Z","steps":["trace[1643146123] 'process raft request' (duration: 124.199239ms)","trace[1643146123] 'compare' (duration: 77.906046ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:47.524878Z","caller":"traceutil/trace.go:172","msg":"trace[551834610] range","detail":"{range_begin:/registry/roles; range_end:; response_count:0; response_revision:775; }","duration":"201.607514ms","start":"2026-05-20T21:25:47.323248Z","end":"2026-05-20T21:25:47.524856Z","steps":["trace[551834610] 'agreement among raft nodes before linearized reading' (duration: 123.444908ms)","trace[551834610] 'range keys from in-memory index tree' (duration: 77.990596ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:47.606537Z","caller":"traceutil/trace.go:172","msg":"trace[1268186851] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:808; }","duration":"159.815604ms","start":"2026-05-20T21:25:47.446675Z","end":"2026-05-20T21:25:47.606490Z","steps":["trace[1268186851] 'read index received' (duration: 159.801294ms)","trace[1268186851] 'applied index is now lower than readState.Index' (duration: 10.86µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:25:47.606737Z","caller":"traceutil/trace.go:172","msg":"trace[878172086] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"282.689092ms","start":"2026-05-20T21:25:47.324032Z","end":"2026-05-20T21:25:47.606721Z","steps":["trace[878172086] 'process raft request' (duration: 282.482882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:47.606837Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"192.338507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-20T21:25:47.606984Z","caller":"traceutil/trace.go:172","msg":"trace[1701262177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:776; }","duration":"192.463667ms","start":"2026-05-20T21:25:47.414472Z","end":"2026-05-20T21:25:47.606935Z","steps":["trace[1701262177] 'agreement among raft nodes before linearized reading' (duration: 192.115487ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:47.607079Z","caller":"traceutil/trace.go:172","msg":"trace[1154798694] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"168.0076ms","start":"2026-05-20T21:25:47.439049Z","end":"2026-05-20T21:25:47.607057Z","steps":["trace[1154798694] 'process raft request' (duration: 167.659689ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:47.606779Z","caller":"traceutil/trace.go:172","msg":"trace[1720983638] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"168.27315ms","start":"2026-05-20T21:25:47.438485Z","end":"2026-05-20T21:25:47.606758Z","steps":["trace[1720983638] 'process raft request' (duration: 168.18509ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:50.960348Z","caller":"traceutil/trace.go:172","msg":"trace[824699581] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"176.288016ms","start":"2026-05-20T21:25:50.784042Z","end":"2026-05-20T21:25:50.960330Z","steps":["trace[824699581] 'process raft request' (duration: 176.169916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:53.622073Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654896263,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:25:54.123034Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654896263,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:25:54.248060Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.279460634s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T21:25:54.248256Z","caller":"traceutil/trace.go:172","msg":"trace[794850299] linearizableReadLoop","detail":"{readStateIndex:852; appliedIndex:852; }","duration":"1.126975845s","start":"2026-05-20T21:25:53.121247Z","end":"2026-05-20T21:25:54.248223Z","steps":["trace[794850299] 'read index received' (duration: 1.126963645s)","trace[794850299] 'applied index is now lower than readState.Index' (duration: 10.9µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:54.248480Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.127216095s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:54.248508Z","caller":"traceutil/trace.go:172","msg":"trace[1204048125] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"1.279987794s","start":"2026-05-20T21:25:52.968504Z","end":"2026-05-20T21:25:54.248492Z","steps":["trace[1204048125] 'process raft request' (duration: 1.279889764s)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:54.248553Z","caller":"traceutil/trace.go:172","msg":"trace[617426496] range","detail":"{range_begin:/registry/resourcequotas; range_end:; response_count:0; response_revision:819; }","duration":"1.127307775s","start":"2026-05-20T21:25:53.121229Z","end":"2026-05-20T21:25:54.248537Z","steps":["trace[617426496] 'agreement among raft nodes before linearized reading' (duration: 1.127168525s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:54.248599Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:52.968482Z","time spent":"1.280069304s","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":478,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:25:54.248602Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:53.121202Z","time spent":"1.127390825s","remote":"127.0.0.1:53006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas\" limit:1 "} {"level":"info","ts":"2026-05-20T21:25:54.584350Z","caller":"traceutil/trace.go:172","msg":"trace[756688463] linearizableReadLoop","detail":"{readStateIndex:853; appliedIndex:853; }","duration":"335.9567ms","start":"2026-05-20T21:25:54.248361Z","end":"2026-05-20T21:25:54.584318Z","steps":["trace[756688463] 'read index received' (duration: 335.94632ms)","trace[756688463] 'applied index is now lower than readState.Index' (duration: 8.8µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:54.584577Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"724.583647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:54.584671Z","caller":"traceutil/trace.go:172","msg":"trace[1370645835] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:820; }","duration":"724.683967ms","start":"2026-05-20T21:25:53.859970Z","end":"2026-05-20T21:25:54.584654Z","steps":["trace[1370645835] 'agreement among raft nodes before linearized reading' (duration: 724.528207ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:54.584722Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:53.859948Z","time spent":"724.765747ms","remote":"127.0.0.1:52820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T21:25:54.584703Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.033122768s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicybindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:54.584808Z","caller":"traceutil/trace.go:172","msg":"trace[602303820] range","detail":"{range_begin:/registry/validatingadmissionpolicybindings; range_end:; response_count:0; response_revision:820; }","duration":"1.033245078s","start":"2026-05-20T21:25:53.551540Z","end":"2026-05-20T21:25:54.584785Z","steps":["trace[602303820] 'agreement among raft nodes before linearized reading' (duration: 1.033036238s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:54.584883Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:53.551519Z","time spent":"1.033352218s","remote":"127.0.0.1:53818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/validatingadmissionpolicybindings\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:54.584979Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"918.948066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T21:25:54.585048Z","caller":"traceutil/trace.go:172","msg":"trace[934214306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:820; }","duration":"919.026796ms","start":"2026-05-20T21:25:53.666009Z","end":"2026-05-20T21:25:54.585036Z","steps":["trace[934214306] 'agreement among raft nodes before linearized reading' (duration: 918.787976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:54.585078Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:53.665977Z","time spent":"919.093736ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:25:54.585250Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.054204573s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:25:54.585248Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"905.867477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T21:25:54.585280Z","caller":"traceutil/trace.go:172","msg":"trace[1274112911] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:820; }","duration":"1.054235613s","start":"2026-05-20T21:25:53.531038Z","end":"2026-05-20T21:25:54.585274Z","steps":["trace[1274112911] 'agreement among raft nodes before linearized reading' (duration: 1.053585412s)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:54.585293Z","caller":"traceutil/trace.go:172","msg":"trace[2056925731] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:820; }","duration":"905.919537ms","start":"2026-05-20T21:25:53.679362Z","end":"2026-05-20T21:25:54.585282Z","steps":["trace[2056925731] 'agreement among raft nodes before linearized reading' (duration: 905.467726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:54.585321Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:53.679337Z","time spent":"905.976487ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-05-20T21:25:54.585594Z","caller":"traceutil/trace.go:172","msg":"trace[711546955] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"958.285595ms","start":"2026-05-20T21:25:53.627295Z","end":"2026-05-20T21:25:54.585581Z","steps":["trace[711546955] 'process raft request' (duration: 957.256594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:54.585611Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.440770559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:25:54.585704Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:53.627267Z","time spent":"958.364525ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:25:54.586056Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"242.373623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:25:54.586092Z","caller":"traceutil/trace.go:172","msg":"trace[468988815] range","detail":"{range_begin:/registry/ingress; range_end:; response_count:0; response_revision:823; }","duration":"242.408383ms","start":"2026-05-20T21:25:54.343675Z","end":"2026-05-20T21:25:54.586084Z","steps":["trace[468988815] 'agreement among raft nodes before linearized reading' (duration: 242.357973ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:54.586302Z","caller":"traceutil/trace.go:172","msg":"trace[110055360] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"841.05578ms","start":"2026-05-20T21:25:53.745237Z","end":"2026-05-20T21:25:54.586293Z","steps":["trace[110055360] 'process raft request' (duration: 840.44052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:54.586373Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:53.745202Z","time spent":"841.12652ms","remote":"127.0.0.1:53284","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-05-20T21:25:54.586568Z","caller":"traceutil/trace.go:172","msg":"trace[1277925311] range","detail":"{range_begin:/registry/csidrivers; range_end:; response_count:0; response_revision:821; }","duration":"1.440908359s","start":"2026-05-20T21:25:53.144806Z","end":"2026-05-20T21:25:54.585715Z","steps":["trace[1277925311] 'agreement among raft nodes before linearized reading' (duration: 1.439835888s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:54.586652Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:53.144789Z","time spent":"1.44184982s","remote":"127.0.0.1:53652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers\" limit:1 "} {"level":"info","ts":"2026-05-20T21:25:54.585816Z","caller":"traceutil/trace.go:172","msg":"trace[694728087] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"956.144373ms","start":"2026-05-20T21:25:53.629662Z","end":"2026-05-20T21:25:54.585806Z","steps":["trace[694728087] 'process raft request' (duration: 955.970223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:54.587511Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:53.629633Z","time spent":"957.843084ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:56.459533Z","caller":"traceutil/trace.go:172","msg":"trace[1492923936] linearizableReadLoop","detail":"{readStateIndex:862; appliedIndex:862; }","duration":"205.806087ms","start":"2026-05-20T21:25:56.253685Z","end":"2026-05-20T21:25:56.459491Z","steps":["trace[1492923936] 'read index received' (duration: 205.796877ms)","trace[1492923936] 'applied index is now lower than readState.Index' (duration: 7.67µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:56.459715Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"206.011937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-20T21:25:56.459745Z","caller":"traceutil/trace.go:172","msg":"trace[485478037] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:828; }","duration":"206.057727ms","start":"2026-05-20T21:25:56.253679Z","end":"2026-05-20T21:25:56.459736Z","steps":["trace[485478037] 'agreement among raft nodes before linearized reading' (duration: 205.916787ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:56.459753Z","caller":"traceutil/trace.go:172","msg":"trace[1116595129] transaction","detail":"{read_only:false; number_of_response:1; response_revision:829; }","duration":"278.981659ms","start":"2026-05-20T21:25:56.180753Z","end":"2026-05-20T21:25:56.459734Z","steps":["trace[1116595129] 'process raft request' (duration: 278.794569ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:56.722462Z","caller":"traceutil/trace.go:172","msg":"trace[773832500] linearizableReadLoop","detail":"{readStateIndex:864; appliedIndex:864; }","duration":"127.583631ms","start":"2026-05-20T21:25:56.594839Z","end":"2026-05-20T21:25:56.722423Z","steps":["trace[773832500] 'read index received' (duration: 127.566231ms)","trace[773832500] 'applied index is now lower than readState.Index' (duration: 9.01µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:56.722766Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"127.904101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T21:25:56.722859Z","caller":"traceutil/trace.go:172","msg":"trace[1479729339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:830; }","duration":"128.007511ms","start":"2026-05-20T21:25:56.594834Z","end":"2026-05-20T21:25:56.722842Z","steps":["trace[1479729339] 'agreement among raft nodes before linearized reading' (duration: 127.762931ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:56.723213Z","caller":"traceutil/trace.go:172","msg":"trace[1197643590] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"141.659172ms","start":"2026-05-20T21:25:56.581523Z","end":"2026-05-20T21:25:56.723182Z","steps":["trace[1197643590] 'process raft request' (duration: 141.003961ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:56.762421Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"156.703632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T21:25:56.762546Z","caller":"traceutil/trace.go:172","msg":"trace[1428840746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:831; }","duration":"156.833952ms","start":"2026-05-20T21:25:56.605690Z","end":"2026-05-20T21:25:56.762524Z","steps":["trace[1428840746] 'agreement among raft nodes before linearized reading' (duration: 156.580682ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:56.762576Z","caller":"traceutil/trace.go:172","msg":"trace[1524892298] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"171.023292ms","start":"2026-05-20T21:25:56.591535Z","end":"2026-05-20T21:25:56.762558Z","steps":["trace[1524892298] 'process raft request' (duration: 170.964932ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:56.762741Z","caller":"traceutil/trace.go:172","msg":"trace[1135279825] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"171.351093ms","start":"2026-05-20T21:25:56.591364Z","end":"2026-05-20T21:25:56.762715Z","steps":["trace[1135279825] 'process raft request' (duration: 171.010113ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:25:57.027752Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"293.83363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4lx84\" limit:1 ","response":"range_response_count:1 size:4757"} {"level":"info","ts":"2026-05-20T21:25:57.027851Z","caller":"traceutil/trace.go:172","msg":"trace[1038296675] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4lx84; range_end:; response_count:1; response_revision:833; }","duration":"293.9377ms","start":"2026-05-20T21:25:56.733890Z","end":"2026-05-20T21:25:57.027827Z","steps":["trace[1038296675] 'agreement among raft nodes before linearized reading' (duration: 67.047498ms)","trace[1038296675] 'range keys from in-memory index tree' (duration: 226.729832ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:57.028227Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"227.179432ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:25:57.028373Z","caller":"traceutil/trace.go:172","msg":"trace[1135485415] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"301.086785ms","start":"2026-05-20T21:25:56.727269Z","end":"2026-05-20T21:25:57.028355Z","steps":["trace[1135485415] 'process raft request' (duration: 73.712392ms)","trace[1135485415] 'compare' (duration: 226.630642ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:25:57.028450Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:25:56.727224Z","time spent":"301.189836ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:25:57.028788Z","caller":"traceutil/trace.go:172","msg":"trace[2028745853] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"260.555226ms","start":"2026-05-20T21:25:56.768202Z","end":"2026-05-20T21:25:57.028758Z","steps":["trace[2028745853] 'process raft request' (duration: 260.106116ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:59.155810Z","caller":"traceutil/trace.go:172","msg":"trace[1601400009] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"118.656855ms","start":"2026-05-20T21:25:59.037137Z","end":"2026-05-20T21:25:59.155794Z","steps":["trace[1601400009] 'process raft request' (duration: 118.621755ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:25:59.155884Z","caller":"traceutil/trace.go:172","msg":"trace[1029358493] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"118.872295ms","start":"2026-05-20T21:25:59.036998Z","end":"2026-05-20T21:25:59.155870Z","steps":["trace[1029358493] 'process raft request' (duration: 117.604574ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:00.643819Z","caller":"traceutil/trace.go:172","msg":"trace[390570442] linearizableReadLoop","detail":"{readStateIndex:917; appliedIndex:917; }","duration":"112.923241ms","start":"2026-05-20T21:26:00.530860Z","end":"2026-05-20T21:26:00.643783Z","steps":["trace[390570442] 'read index received' (duration: 112.917321ms)","trace[390570442] 'applied index is now lower than readState.Index' (duration: 5µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:26:00.643946Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"113.097371ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:26:00.644007Z","caller":"traceutil/trace.go:172","msg":"trace[1540999271] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:883; }","duration":"113.175771ms","start":"2026-05-20T21:26:00.530820Z","end":"2026-05-20T21:26:00.643995Z","steps":["trace[1540999271] 'agreement among raft nodes before linearized reading' (duration: 113.069261ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:00.644008Z","caller":"traceutil/trace.go:172","msg":"trace[572474576] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"156.903692ms","start":"2026-05-20T21:26:00.487092Z","end":"2026-05-20T21:26:00.643995Z","steps":["trace[572474576] 'process raft request' (duration: 156.782742ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:01.085060Z","caller":"traceutil/trace.go:172","msg":"trace[1500438260] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:918; }","duration":"225.264421ms","start":"2026-05-20T21:26:00.859769Z","end":"2026-05-20T21:26:01.085033Z","steps":["trace[1500438260] 'read index received' (duration: 225.256121ms)","trace[1500438260] 'applied index is now lower than readState.Index' (duration: 7.07µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:26:01.085248Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"225.469131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:26:01.085271Z","caller":"traceutil/trace.go:172","msg":"trace[1498857554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:884; }","duration":"225.510701ms","start":"2026-05-20T21:26:00.859753Z","end":"2026-05-20T21:26:01.085264Z","steps":["trace[1498857554] 'agreement among raft nodes before linearized reading' (duration: 225.424741ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:01.085402Z","caller":"traceutil/trace.go:172","msg":"trace[805083203] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"312.916623ms","start":"2026-05-20T21:26:00.772454Z","end":"2026-05-20T21:26:01.085370Z","steps":["trace[805083203] 'process raft request' (duration: 312.620663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:26:01.085638Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:26:00.772424Z","time spent":"313.099043ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:26:01.146041Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"104.503075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.103\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-20T21:26:01.146170Z","caller":"traceutil/trace.go:172","msg":"trace[81888186] range","detail":"{range_begin:/registry/masterleases/199.19.213.103; range_end:; response_count:1; response_revision:885; }","duration":"104.648355ms","start":"2026-05-20T21:26:01.041501Z","end":"2026-05-20T21:26:01.146150Z","steps":["trace[81888186] 'agreement among raft nodes before linearized reading' (duration: 104.388504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:26:01.146455Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"265.41592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:26:01.146549Z","caller":"traceutil/trace.go:172","msg":"trace[1998637351] range","detail":"{range_begin:/registry/horizontalpodautoscalers; range_end:; response_count:0; response_revision:886; }","duration":"265.50545ms","start":"2026-05-20T21:26:00.881026Z","end":"2026-05-20T21:26:01.146531Z","steps":["trace[1998637351] 'agreement among raft nodes before linearized reading' (duration: 265.38868ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:01.147266Z","caller":"traceutil/trace.go:172","msg":"trace[744943538] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"372.449036ms","start":"2026-05-20T21:26:00.774786Z","end":"2026-05-20T21:26:01.147235Z","steps":["trace[744943538] 'process raft request' (duration: 371.194345ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:01.147350Z","caller":"traceutil/trace.go:172","msg":"trace[1502515044] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"205.970307ms","start":"2026-05-20T21:26:00.941360Z","end":"2026-05-20T21:26:01.147331Z","steps":["trace[1502515044] 'process raft request' (duration: 205.707287ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:26:01.147492Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:26:00.774772Z","time spent":"372.591446ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:26:08.221417Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60424","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:26:08.245453Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60426","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:26:08.257849Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60460","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-05-20T21:26:08.275198Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60462","server-name":"","error":"EOF"} {"level":"info","ts":"2026-05-20T21:26:09.228700Z","caller":"traceutil/trace.go:172","msg":"trace[1187618167] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"115.928112ms","start":"2026-05-20T21:26:09.112750Z","end":"2026-05-20T21:26:09.228678Z","steps":["trace[1187618167] 'process raft request' (duration: 115.750892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:26:10.988248Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"130.907533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:26:10.988365Z","caller":"traceutil/trace.go:172","msg":"trace[325457962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:923; }","duration":"131.036433ms","start":"2026-05-20T21:26:10.857301Z","end":"2026-05-20T21:26:10.988337Z","steps":["trace[325457962] 'range keys from in-memory index tree' (duration: 130.795563ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:11.461618Z","caller":"traceutil/trace.go:172","msg":"trace[426544462] linearizableReadLoop","detail":"{readStateIndex:963; appliedIndex:963; }","duration":"117.520374ms","start":"2026-05-20T21:26:11.344069Z","end":"2026-05-20T21:26:11.461589Z","steps":["trace[426544462] 'read index received' (duration: 117.502374ms)","trace[426544462] 'applied index is now lower than readState.Index' (duration: 16.52µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:26:11.464557Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"120.483436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T21:26:11.464818Z","caller":"traceutil/trace.go:172","msg":"trace[1929503643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:926; }","duration":"120.754287ms","start":"2026-05-20T21:26:11.344050Z","end":"2026-05-20T21:26:11.464805Z","steps":["trace[1929503643] 'agreement among raft nodes before linearized reading' (duration: 117.620364ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:11.465337Z","caller":"traceutil/trace.go:172","msg":"trace[379379502] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"147.479035ms","start":"2026-05-20T21:26:11.317840Z","end":"2026-05-20T21:26:11.465319Z","steps":["trace[379379502] 'process raft request' (duration: 143.757302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:26:11.465408Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"105.016575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T21:26:11.465584Z","caller":"traceutil/trace.go:172","msg":"trace[416110956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:927; }","duration":"105.195185ms","start":"2026-05-20T21:26:11.360367Z","end":"2026-05-20T21:26:11.465563Z","steps":["trace[416110956] 'agreement among raft nodes before linearized reading' (duration: 104.877215ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:11.859435Z","caller":"traceutil/trace.go:172","msg":"trace[1326271896] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:965; }","duration":"328.271254ms","start":"2026-05-20T21:26:11.531068Z","end":"2026-05-20T21:26:11.859339Z","steps":["trace[1326271896] 'read index received' (duration: 328.266984ms)","trace[1326271896] 'applied index is now lower than readState.Index' (duration: 3.4µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:26:11.859644Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"328.568315ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:26:11.859717Z","caller":"traceutil/trace.go:172","msg":"trace[2041040175] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:928; }","duration":"328.649605ms","start":"2026-05-20T21:26:11.531059Z","end":"2026-05-20T21:26:11.859709Z","steps":["trace[2041040175] 'agreement among raft nodes before linearized reading' (duration: 328.433514ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:11.859911Z","caller":"traceutil/trace.go:172","msg":"trace[1594895175] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"389.439498ms","start":"2026-05-20T21:26:11.470464Z","end":"2026-05-20T21:26:11.859903Z","steps":["trace[1594895175] 'process raft request' (duration: 388.954627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:26:11.860000Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:26:11.470443Z","time spent":"389.494748ms","remote":"127.0.0.1:53332","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-05-20T21:26:12.458306Z","caller":"traceutil/trace.go:172","msg":"trace[1693393835] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"224.61597ms","start":"2026-05-20T21:26:12.233671Z","end":"2026-05-20T21:26:12.458287Z","steps":["trace[1693393835] 'process raft request' (duration: 224.41656ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:13.085315Z","caller":"traceutil/trace.go:172","msg":"trace[1804875593] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:967; }","duration":"226.020392ms","start":"2026-05-20T21:26:12.859270Z","end":"2026-05-20T21:26:13.085291Z","steps":["trace[1804875593] 'read index received' (duration: 226.012172ms)","trace[1804875593] 'applied index is now lower than readState.Index' (duration: 7.11µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:26:13.085470Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"226.188642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:26:13.085511Z","caller":"traceutil/trace.go:172","msg":"trace[1241775405] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:930; }","duration":"226.246002ms","start":"2026-05-20T21:26:12.859253Z","end":"2026-05-20T21:26:13.085499Z","steps":["trace[1241775405] 'agreement among raft nodes before linearized reading' (duration: 226.138292ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:13.085490Z","caller":"traceutil/trace.go:172","msg":"trace[858371476] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"335.118779ms","start":"2026-05-20T21:26:12.750347Z","end":"2026-05-20T21:26:13.085466Z","steps":["trace[858371476] 'process raft request' (duration: 334.983809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:26:13.085631Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:26:12.750322Z","time spent":"335.239359ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":478,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:26:13.419415Z","caller":"traceutil/trace.go:172","msg":"trace[1332437544] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"155.918952ms","start":"2026-05-20T21:26:13.263468Z","end":"2026-05-20T21:26:13.419387Z","steps":["trace[1332437544] 'process raft request' (duration: 120.245996ms)","trace[1332437544] 'compare' (duration: 35.567975ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:26:15.333978Z","caller":"traceutil/trace.go:172","msg":"trace[2009518868] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"241.002082ms","start":"2026-05-20T21:26:15.092951Z","end":"2026-05-20T21:26:15.333953Z","steps":["trace[2009518868] 'process raft request' (duration: 240.869132ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:15.335248Z","caller":"traceutil/trace.go:172","msg":"trace[607960633] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"178.974448ms","start":"2026-05-20T21:26:15.156246Z","end":"2026-05-20T21:26:15.335220Z","steps":["trace[607960633] 'process raft request' (duration: 178.761578ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:15.544227Z","caller":"traceutil/trace.go:172","msg":"trace[917761740] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"118.334834ms","start":"2026-05-20T21:26:15.425867Z","end":"2026-05-20T21:26:15.544202Z","steps":["trace[917761740] 'process raft request' (duration: 70.82613ms)","trace[917761740] 'compare' (duration: 47.335884ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:26:15.552129Z","caller":"traceutil/trace.go:172","msg":"trace[1682014077] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"117.751534ms","start":"2026-05-20T21:26:15.434336Z","end":"2026-05-20T21:26:15.552087Z","steps":["trace[1682014077] 'process raft request' (duration: 117.552854ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:16.022139Z","caller":"traceutil/trace.go:172","msg":"trace[1003583823] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"129.631092ms","start":"2026-05-20T21:26:15.892459Z","end":"2026-05-20T21:26:16.022090Z","steps":["trace[1003583823] 'process raft request' (duration: 129.463952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:26:16.923226Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"236.448939ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-20T21:26:18.032376Z","caller":"traceutil/trace.go:172","msg":"trace[1339360309] linearizableReadLoop","detail":"{readStateIndex:983; appliedIndex:983; }","duration":"414.553606ms","start":"2026-05-20T21:26:17.617791Z","end":"2026-05-20T21:26:18.032344Z","steps":["trace[1339360309] 'read index received' (duration: 414.539996ms)","trace[1339360309] 'applied index is now lower than readState.Index' (duration: 11.8µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:26:18.034669Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"471.390957ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:26:18.034747Z","caller":"traceutil/trace.go:172","msg":"trace[1314621791] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:945; }","duration":"471.475277ms","start":"2026-05-20T21:26:17.563256Z","end":"2026-05-20T21:26:18.034732Z","steps":["trace[1314621791] 'agreement among raft nodes before linearized reading' (duration: 469.231675ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:18.034908Z","caller":"traceutil/trace.go:172","msg":"trace[302493359] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"476.27785ms","start":"2026-05-20T21:26:17.558616Z","end":"2026-05-20T21:26:18.034894Z","steps":["trace[302493359] 'process raft request' (duration: 476.23469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:26:18.035014Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:26:17.558607Z","time spent":"476.35209ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:26:18.034931Z","caller":"traceutil/trace.go:172","msg":"trace[2137165863] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"476.982631ms","start":"2026-05-20T21:26:17.557919Z","end":"2026-05-20T21:26:18.034902Z","steps":["trace[2137165863] 'process raft request' (duration: 474.473839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:26:18.035259Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:26:17.557891Z","time spent":"477.281021ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:26:18.262324Z","caller":"traceutil/trace.go:172","msg":"trace[859455859] linearizableReadLoop","detail":"{readStateIndex:985; appliedIndex:985; }","duration":"229.844535ms","start":"2026-05-20T21:26:18.032458Z","end":"2026-05-20T21:26:18.262302Z","steps":["trace[859455859] 'read index received' (duration: 229.836454ms)","trace[859455859] 'applied index is now lower than readState.Index' (duration: 6.921µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:26:18.274332Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"248.790558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T21:26:18.274386Z","caller":"traceutil/trace.go:172","msg":"trace[825972784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:947; }","duration":"248.854918ms","start":"2026-05-20T21:26:18.025518Z","end":"2026-05-20T21:26:18.274373Z","steps":["trace[825972784] 'agreement among raft nodes before linearized reading' (duration: 236.89597ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:18.274911Z","caller":"traceutil/trace.go:172","msg":"trace[1696473599] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"652.739356ms","start":"2026-05-20T21:26:17.622055Z","end":"2026-05-20T21:26:18.274794Z","steps":["trace[1696473599] 'process raft request' (duration: 640.567308ms)","trace[1696473599] 'compare' (duration: 11.937248ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:26:18.275303Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:26:17.622035Z","time spent":"653.042267ms","remote":"127.0.0.1:53332","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-05-20T21:26:19.675224Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"143.951733ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:26:19.675609Z","caller":"traceutil/trace.go:172","msg":"trace[339024087] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:950; }","duration":"144.343483ms","start":"2026-05-20T21:26:19.531248Z","end":"2026-05-20T21:26:19.675592Z","steps":["trace[339024087] 'range keys from in-memory index tree' (duration: 143.899813ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:19.737952Z","caller":"traceutil/trace.go:172","msg":"trace[1519552004] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"113.868611ms","start":"2026-05-20T21:26:19.624061Z","end":"2026-05-20T21:26:19.737930Z","steps":["trace[1519552004] 'process raft request' (duration: 113.661511ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:21.969439Z","caller":"traceutil/trace.go:172","msg":"trace[925991390] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"226.138121ms","start":"2026-05-20T21:26:21.743279Z","end":"2026-05-20T21:26:21.969417Z","steps":["trace[925991390] 'process raft request' (duration: 226.006571ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:22.183465Z","caller":"traceutil/trace.go:172","msg":"trace[1084126273] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"128.706862ms","start":"2026-05-20T21:26:22.054737Z","end":"2026-05-20T21:26:22.183444Z","steps":["trace[1084126273] 'process raft request' (duration: 122.769718ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:22.184473Z","caller":"traceutil/trace.go:172","msg":"trace[1464616878] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"125.30359ms","start":"2026-05-20T21:26:22.059144Z","end":"2026-05-20T21:26:22.184447Z","steps":["trace[1464616878] 'process raft request' (duration: 125.19279ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:22.565533Z","caller":"traceutil/trace.go:172","msg":"trace[540788049] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"210.809851ms","start":"2026-05-20T21:26:22.354701Z","end":"2026-05-20T21:26:22.565511Z","steps":["trace[540788049] 'process raft request' (duration: 164.668378ms)","trace[540788049] 'compare' (duration: 46.028883ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:26:36.512760Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"150.744697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:26:36.512881Z","caller":"traceutil/trace.go:172","msg":"trace[870752566] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"224.466691ms","start":"2026-05-20T21:26:36.288398Z","end":"2026-05-20T21:26:36.512864Z","steps":["trace[870752566] 'process raft request' (duration: 73.551403ms)","trace[870752566] 'compare' (duration: 150.618117ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:26:36.695763Z","caller":"traceutil/trace.go:172","msg":"trace[376736620] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1053; }","duration":"164.528297ms","start":"2026-05-20T21:26:36.531216Z","end":"2026-05-20T21:26:36.695744Z","steps":["trace[376736620] 'read index received' (duration: 164.517457ms)","trace[376736620] 'applied index is now lower than readState.Index' (duration: 9.89µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:26:36.697037Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"165.808438ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:26:36.697223Z","caller":"traceutil/trace.go:172","msg":"trace[51681216] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1011; }","duration":"166.007318ms","start":"2026-05-20T21:26:36.531208Z","end":"2026-05-20T21:26:36.697215Z","steps":["trace[51681216] 'agreement among raft nodes before linearized reading' (duration: 164.705097ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:26:36.697701Z","caller":"traceutil/trace.go:172","msg":"trace[816327100] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"180.443449ms","start":"2026-05-20T21:26:36.517232Z","end":"2026-05-20T21:26:36.697676Z","steps":["trace[816327100] 'process raft request' (duration: 178.707737ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:27:05.023459Z","caller":"traceutil/trace.go:172","msg":"trace[1884684605] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1150; }","duration":"149.647447ms","start":"2026-05-20T21:27:04.873782Z","end":"2026-05-20T21:27:05.023429Z","steps":["trace[1884684605] 'read index received' (duration: 149.637797ms)","trace[1884684605] 'applied index is now lower than readState.Index' (duration: 8.15µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T21:27:05.023711Z","caller":"traceutil/trace.go:172","msg":"trace[957092469] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"150.869078ms","start":"2026-05-20T21:27:04.872788Z","end":"2026-05-20T21:27:05.023657Z","steps":["trace[957092469] 'process raft request' (duration: 150.742438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:05.024291Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"150.446477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-20T21:27:05.024421Z","caller":"traceutil/trace.go:172","msg":"trace[1573361150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1104; }","duration":"150.615457ms","start":"2026-05-20T21:27:04.873780Z","end":"2026-05-20T21:27:05.024395Z","steps":["trace[1573361150] 'agreement among raft nodes before linearized reading' (duration: 150.171627ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:27:10.111139Z","caller":"traceutil/trace.go:172","msg":"trace[1802325403] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"176.755437ms","start":"2026-05-20T21:27:09.934365Z","end":"2026-05-20T21:27:10.111120Z","steps":["trace[1802325403] 'process raft request' (duration: 176.623856ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:27:10.348821Z","caller":"traceutil/trace.go:172","msg":"trace[2056936313] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"121.388216ms","start":"2026-05-20T21:27:10.227409Z","end":"2026-05-20T21:27:10.348797Z","steps":["trace[2056936313] 'process raft request' (duration: 121.256926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:13.101571Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2396933455654897098,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T21:27:13.115475Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"584.372087ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:27:13.115550Z","caller":"traceutil/trace.go:172","msg":"trace[2021891139] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1127; }","duration":"584.462177ms","start":"2026-05-20T21:27:12.531074Z","end":"2026-05-20T21:27:13.115536Z","steps":["trace[2021891139] 'range keys from in-memory index tree' (duration: 584.305467ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:27:13.141179Z","caller":"traceutil/trace.go:172","msg":"trace[1749567344] linearizableReadLoop","detail":"{readStateIndex:1176; appliedIndex:1176; }","duration":"539.925016ms","start":"2026-05-20T21:27:12.601224Z","end":"2026-05-20T21:27:13.141149Z","steps":["trace[1749567344] 'read index received' (duration: 539.914416ms)","trace[1749567344] 'applied index is now lower than readState.Index' (duration: 9.37µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:13.141325Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"540.093486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:27:13.141358Z","caller":"traceutil/trace.go:172","msg":"trace[1390840788] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs; range_end:; response_count:0; response_revision:1127; }","duration":"540.136746ms","start":"2026-05-20T21:27:12.601212Z","end":"2026-05-20T21:27:13.141348Z","steps":["trace[1390840788] 'agreement among raft nodes before linearized reading' (duration: 540.056976ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:27:13.141347Z","caller":"traceutil/trace.go:172","msg":"trace[810833585] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"669.132568ms","start":"2026-05-20T21:27:12.472191Z","end":"2026-05-20T21:27:13.141324Z","steps":["trace[810833585] 'process raft request' (duration: 669.021008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:13.141383Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:27:12.601190Z","time spent":"540.187516ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:27:13.141505Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:27:12.472163Z","time spent":"669.274178ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:27:13.363960Z","caller":"traceutil/trace.go:172","msg":"trace[1429984803] linearizableReadLoop","detail":"{readStateIndex:1177; appliedIndex:1177; }","duration":"222.687489ms","start":"2026-05-20T21:27:13.141256Z","end":"2026-05-20T21:27:13.363943Z","steps":["trace[1429984803] 'read index received' (duration: 222.672859ms)","trace[1429984803] 'applied index is now lower than readState.Index' (duration: 13.86µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:13.686891Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"561.638461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-20T21:27:13.686960Z","caller":"traceutil/trace.go:172","msg":"trace[1055257947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1128; }","duration":"561.710241ms","start":"2026-05-20T21:27:13.125234Z","end":"2026-05-20T21:27:13.686944Z","steps":["trace[1055257947] 'agreement among raft nodes before linearized reading' (duration: 238.705021ms)","trace[1055257947] 'range keys from in-memory index tree' (duration: 322.83245ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:13.686989Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:27:13.125219Z","time spent":"561.761872ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:27:13.687012Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"571.420279ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:27:13.687039Z","caller":"traceutil/trace.go:172","msg":"trace[668875273] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1128; }","duration":"571.451119ms","start":"2026-05-20T21:27:13.115578Z","end":"2026-05-20T21:27:13.687030Z","steps":["trace[668875273] 'agreement among raft nodes before linearized reading' (duration: 248.379148ms)","trace[668875273] 'range keys from in-memory index tree' (duration: 323.035291ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:13.687254Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"597.571687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-20T21:27:13.687283Z","caller":"traceutil/trace.go:172","msg":"trace[737563855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1128; }","duration":"597.601207ms","start":"2026-05-20T21:27:13.089674Z","end":"2026-05-20T21:27:13.687276Z","steps":["trace[737563855] 'agreement among raft nodes before linearized reading' (duration: 274.287216ms)","trace[737563855] 'range keys from in-memory index tree' (duration: 323.239081ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:13.687300Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:27:13.089651Z","time spent":"597.644327ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-05-20T21:27:13.687397Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"828.214752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:27:13.687422Z","caller":"traceutil/trace.go:172","msg":"trace[449272887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1128; }","duration":"828.238432ms","start":"2026-05-20T21:27:12.859176Z","end":"2026-05-20T21:27:13.687415Z","steps":["trace[449272887] 'agreement among raft nodes before linearized reading' (duration: 504.834441ms)","trace[449272887] 'range keys from in-memory index tree' (duration: 323.369841ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:13.687439Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:27:12.859148Z","time spent":"828.287132ms","remote":"127.0.0.1:52820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-20T21:27:13.687954Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"323.892861ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:27:13.688407Z","caller":"traceutil/trace.go:172","msg":"trace[1082581446] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"457.324947ms","start":"2026-05-20T21:27:13.231074Z","end":"2026-05-20T21:27:13.688399Z","steps":["trace[1082581446] 'process raft request' (duration: 456.975796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:13.688453Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:27:13.231051Z","time spent":"457.380917ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":674,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:27:13.688531Z","caller":"traceutil/trace.go:172","msg":"trace[948833198] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"971.402514ms","start":"2026-05-20T21:27:12.717119Z","end":"2026-05-20T21:27:13.688522Z","steps":["trace[948833198] 'process raft request' (duration: 646.906502ms)","trace[948833198] 'compare' (duration: 323.506661ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:13.688572Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:27:12.717083Z","time spent":"971.470724ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T21:27:14.062834Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"166.285409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:27:14.062891Z","caller":"traceutil/trace.go:172","msg":"trace[638817989] range","detail":"{range_begin:/registry/endpointslices; range_end:; response_count:0; response_revision:1132; }","duration":"166.354939ms","start":"2026-05-20T21:27:13.896525Z","end":"2026-05-20T21:27:14.062880Z","steps":["trace[638817989] 'range keys from in-memory index tree' (duration: 166.191629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:14.062969Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"202.537485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T21:27:14.063062Z","caller":"traceutil/trace.go:172","msg":"trace[1188607465] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1132; }","duration":"202.641925ms","start":"2026-05-20T21:27:13.860393Z","end":"2026-05-20T21:27:14.063035Z","steps":["trace[1188607465] 'range keys from in-memory index tree' (duration: 202.401685ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:27:14.363400Z","caller":"traceutil/trace.go:172","msg":"trace[312337662] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"193.057198ms","start":"2026-05-20T21:27:14.170321Z","end":"2026-05-20T21:27:14.363378Z","steps":["trace[312337662] 'process raft request' (duration: 192.899948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T21:27:14.846586Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"315.614126ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T21:27:14.846660Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"318.361578ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T21:27:14.846687Z","caller":"traceutil/trace.go:172","msg":"trace[1192069180] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1133; }","duration":"315.749276ms","start":"2026-05-20T21:27:14.530919Z","end":"2026-05-20T21:27:14.846668Z","steps":["trace[1192069180] 'range keys from in-memory index tree' (duration: 315.556416ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T21:27:14.846752Z","caller":"traceutil/trace.go:172","msg":"trace[1475870553] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"418.572769ms","start":"2026-05-20T21:27:14.428162Z","end":"2026-05-20T21:27:14.846735Z","steps":["trace[1475870553] 'process raft request' (duration: 100.063881ms)","trace[1475870553] 'compare' (duration: 318.267788ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T21:27:14.846809Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-05-20T21:27:14.428137Z","time spent":"418.647559ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T21:27:33.040405Z","caller":"traceutil/trace.go:172","msg":"trace[730546700] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"104.394934ms","start":"2026-05-20T21:27:32.935994Z","end":"2026-05-20T21:27:33.040389Z","steps":["trace[730546700] 'process raft request' (duration: 104.288474ms)"],"step_count":1}