{"level":"warn","ts":"2026-04-18T17:52:15.098557Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-04-18T17:52:15.098705Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-04-18T17:52:15.098953Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.204.45.23:2380","--initial-cluster=controller=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23:2380","--name=controller","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-04-18T17:52:15.099179Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-04-18T17:52:15.099247Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T17:52:15.099281Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-04-18T17:52:15.099419Z","caller":"embed/etcd.go:544","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-18T17:52:15.101155Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-04-18T17:52:15.101367Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.204.45.23:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"feature-gates":"InitialCorruptCheck=true","initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","discovery-token":"","discovery-endpoints":"","discovery-dial-timeout":"2s","discovery-request-timeout":"5s","discovery-keepalive-time":"2s","discovery-keepalive-timeout":"6s","discovery-insecure-transport":true,"discovery-insecure-skip-tls-verify":false,"discovery-cert":"","discovery-key":"","discovery-cacert":"","discovery-user":"","downgrade-check-interval":"5s","max-learners":1,"v2-deprecation":"write-only"} {"level":"info","ts":"2026-04-18T17:52:15.103011Z","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: 0xc000122280}"} {"level":"info","ts":"2026-04-18T17:52:15.853379Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-04-18T17:52:15.853525Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"750.746623ms"} {"level":"info","ts":"2026-04-18T17:52:15.853580Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-04-18T17:52:15.853606Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-04-18T17:52:15.853711Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-04-18T17:52:15.866727Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-04-18T17:52:15.866840Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-04-18T17:52:15.867176Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-04-18T17:52:15.867273Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T17:52:15.867325Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-04-18T17:52:15.867335Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T17:52:15.867349Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-04-18T17:52:15.867391Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-04-18T17:52:15.875662Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T17:52:15.878734Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T17:52:15.882189Z","caller":"storage/quota.go:93","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-18T17:52:15.883099Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T17:52:15.883366Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T17:52:15.883410Z","caller":"embed/etcd.go:766","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-18T17:52:15.883506Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T17:52:15.883594Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T17:52:15.883621Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T17:52:15.883535Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-04-18T17:52:15.883659Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-04-18T17:52:15.883925Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-04-18T17:52:15.884061Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T17:52:15.883916Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T17:52:15.884351Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-04-18T17:52:16.268349Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T17:52:16.268427Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T17:52:16.268536Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-04-18T17:52:16.268564Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"51a5c416a4d98c86 has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-18T17:52:16.268592Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-04-18T17:52:16.522534Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-04-18T17:52:16.522624Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"51a5c416a4d98c86 has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-18T17:52:16.522660Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-04-18T17:52:16.522673Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-04-18T17:52:16.650404Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-04-18T17:52:16.710994Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:controller ClientURLs:[https://199.204.45.23:2379]}","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T17:52:16.711027Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T17:52:16.711063Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T17:52:16.711468Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T17:52:16.711731Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T17:52:16.712619Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-04-18T17:52:16.714970Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-04-18T17:52:16.715393Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-18T17:52:16.719482Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-04-18T17:52:16.723112Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-18T17:52:16.723454Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43484","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.723524Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43506","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.723538Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43472","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.734560Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43558","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-18T17:52:16.741946Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.6"} {"level":"info","ts":"2026-04-18T17:52:16.742095Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-04-18T17:52:16.742299Z","caller":"version/monitor.go:116","msg":"cluster version differs from storage version.","cluster-version":"3.6.0","storage-version":"3.5.0"} {"level":"info","ts":"2026-04-18T17:52:16.742375Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-04-18T17:52:16.742523Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"warn","ts":"2026-04-18T17:52:16.749357Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43594","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.762385Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43614","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.778179Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43634","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.787065Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43644","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.797196Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43682","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.807292Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43692","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.817042Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43716","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.827492Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43728","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.850194Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43746","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.868899Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43774","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.872601Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43796","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.882407Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43818","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.890733Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43838","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.902229Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43854","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.915529Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43860","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.945264Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43892","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:16.997265Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43914","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.024074Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43932","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.034310Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43962","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.043155Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43978","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.052691Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43990","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.060132Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43996","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.067796Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44028","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.077356Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44044","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.084343Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44066","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.095917Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44098","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.110232Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44134","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.134441Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44146","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.136593Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44192","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.146261Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44198","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.159560Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44228","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.165615Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44248","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.177187Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44268","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.196875Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44302","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.206948Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44316","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.218041Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44328","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.230441Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44342","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.240161Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44354","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.252478Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44364","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.272499Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44380","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.284010Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44398","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.292603Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44414","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.302036Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44418","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.310650Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44438","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.320798Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44458","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.329413Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44472","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.338547Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44492","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.348382Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44502","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.358002Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44520","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.366757Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44548","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.376256Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44562","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.421357Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44590","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.429361Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44600","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:52:17.440846Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44638","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-18T17:52:19.525645Z","caller":"traceutil/trace.go:172","msg":"trace[1707579449] transaction","detail":"{read_only:false; response_revision:156; number_of_response:1; }","duration":"129.532778ms","start":"2026-04-18T17:52:19.396082Z","end":"2026-04-18T17:52:19.525615Z","steps":["trace[1707579449] 'process raft request' (duration: 75.291235ms)","trace[1707579449] 'compare' (duration: 54.041087ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:19.701397Z","caller":"traceutil/trace.go:172","msg":"trace[1879093318] transaction","detail":"{read_only:false; response_revision:157; number_of_response:1; }","duration":"168.591049ms","start":"2026-04-18T17:52:19.532776Z","end":"2026-04-18T17:52:19.701367Z","steps":["trace[1879093318] 'process raft request' (duration: 168.422914ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:21.184649Z","caller":"traceutil/trace.go:172","msg":"trace[1111233899] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"119.872893ms","start":"2026-04-18T17:52:21.064749Z","end":"2026-04-18T17:52:21.184622Z","steps":["trace[1111233899] 'process raft request' (duration: 69.670753ms)","trace[1111233899] 'compare' (duration: 50.098457ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:22.193530Z","caller":"traceutil/trace.go:172","msg":"trace[1161011459] linearizableReadLoop","detail":"{readStateIndex:254; appliedIndex:254; }","duration":"154.116375ms","start":"2026-04-18T17:52:22.039382Z","end":"2026-04-18T17:52:22.193498Z","steps":["trace[1161011459] 'read index received' (duration: 154.102975ms)","trace[1161011459] 'applied index is now lower than readState.Index' (duration: 11.52µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:22.203602Z","caller":"traceutil/trace.go:172","msg":"trace[2126560244] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"192.401982ms","start":"2026-04-18T17:52:22.011165Z","end":"2026-04-18T17:52:22.203567Z","steps":["trace[2126560244] 'process raft request' (duration: 182.572312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:22.203171Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"163.732659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:22.203815Z","caller":"traceutil/trace.go:172","msg":"trace[346221681] range","detail":"{range_begin:/registry/resourceslices; range_end:; response_count:0; response_revision:247; }","duration":"164.43288ms","start":"2026-04-18T17:52:22.039368Z","end":"2026-04-18T17:52:22.203801Z","steps":["trace[346221681] 'agreement among raft nodes before linearized reading' (duration: 154.341072ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.315494Z","caller":"traceutil/trace.go:172","msg":"trace[1941945962] linearizableReadLoop","detail":"{readStateIndex:255; appliedIndex:255; }","duration":"121.830641ms","start":"2026-04-18T17:52:22.193628Z","end":"2026-04-18T17:52:22.315458Z","steps":["trace[1941945962] 'read index received' (duration: 121.819271ms)","trace[1941945962] 'applied index is now lower than readState.Index' (duration: 9.48µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:22.440919Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"313.619914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:22.441039Z","caller":"traceutil/trace.go:172","msg":"trace[1953127025] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:248; }","duration":"313.757148ms","start":"2026-04-18T17:52:22.127261Z","end":"2026-04-18T17:52:22.441018Z","steps":["trace[1953127025] 'agreement among raft nodes before linearized reading' (duration: 188.349878ms)","trace[1953127025] 'range keys from in-memory index tree' (duration: 125.222405ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:22.441094Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.127247Z","time spent":"313.834221ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:22.442453Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"125.864905ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:22.442778Z","caller":"traceutil/trace.go:172","msg":"trace[2005982472] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"428.6986ms","start":"2026-04-18T17:52:22.014051Z","end":"2026-04-18T17:52:22.442750Z","steps":["trace[2005982472] 'process raft request' (duration: 428.530455ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.442796Z","caller":"traceutil/trace.go:172","msg":"trace[941464784] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"415.684124ms","start":"2026-04-18T17:52:22.027089Z","end":"2026-04-18T17:52:22.442773Z","steps":["trace[941464784] 'process raft request' (duration: 415.56085ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.442927Z","caller":"traceutil/trace.go:172","msg":"trace[1962206956] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"346.400553ms","start":"2026-04-18T17:52:22.096497Z","end":"2026-04-18T17:52:22.442898Z","steps":["trace[1962206956] 'process raft request' (duration: 346.243898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:22.442926Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.014046Z","time spent":"428.844504ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":528,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:52:22.443613Z","caller":"traceutil/trace.go:172","msg":"trace[317695583] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"234.618997ms","start":"2026-04-18T17:52:22.208337Z","end":"2026-04-18T17:52:22.442956Z","steps":["trace[317695583] 'process raft request' (duration: 234.572656ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.443715Z","caller":"traceutil/trace.go:172","msg":"trace[126498513] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"429.825644ms","start":"2026-04-18T17:52:22.013851Z","end":"2026-04-18T17:52:22.443677Z","steps":["trace[126498513] 'process raft request' (duration: 301.690461ms)","trace[126498513] 'compare' (duration: 125.626257ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:22.443717Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.027065Z","time spent":"416.617132ms","remote":"127.0.0.1:43888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:52:22.443808Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.013829Z","time spent":"429.942288ms","remote":"127.0.0.1:44402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3482,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:52:22.443840Z","caller":"traceutil/trace.go:172","msg":"trace[255184871] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"346.278429ms","start":"2026-04-18T17:52:22.097548Z","end":"2026-04-18T17:52:22.443826Z","steps":["trace[255184871] 'process raft request' (duration: 345.288929ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.443864Z","caller":"traceutil/trace.go:172","msg":"trace[282934067] transaction","detail":"{read_only:false; number_of_response:0; response_revision:254; }","duration":"301.056132ms","start":"2026-04-18T17:52:22.142792Z","end":"2026-04-18T17:52:22.443848Z","steps":["trace[282934067] 'process raft request' (duration: 300.082982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:22.443893Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.097539Z","time spent":"346.32992ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:52:22.443942Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.142763Z","time spent":"301.140224ms","remote":"127.0.0.1:43840","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:52:22.444015Z","caller":"traceutil/trace.go:172","msg":"trace[1276011747] transaction","detail":"{read_only:false; number_of_response:0; response_revision:253; }","duration":"347.428593ms","start":"2026-04-18T17:52:22.096578Z","end":"2026-04-18T17:52:22.444006Z","steps":["trace[1276011747] 'process raft request' (duration: 346.198836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:22.444066Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.096556Z","time spent":"347.491186ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:52:22.444179Z","caller":"traceutil/trace.go:172","msg":"trace[785387749] transaction","detail":"{read_only:false; number_of_response:0; response_revision:253; }","duration":"347.504076ms","start":"2026-04-18T17:52:22.096666Z","end":"2026-04-18T17:52:22.444170Z","steps":["trace[785387749] 'process raft request' (duration: 346.148305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:22.444226Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.096662Z","time spent":"347.545617ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:52:22.444268Z","caller":"traceutil/trace.go:172","msg":"trace[1455212749] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"348.848207ms","start":"2026-04-18T17:52:22.095404Z","end":"2026-04-18T17:52:22.444252Z","steps":["trace[1455212749] 'process raft request' (duration: 347.290789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:22.444290Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.096485Z","time spent":"346.561147ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4321,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:52:22.444357Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.095378Z","time spent":"348.9407ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5675,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:52:22.798753Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"302.139905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/controller\" limit:1 ","response":"range_response_count:1 size:3595"} {"level":"info","ts":"2026-04-18T17:52:22.798836Z","caller":"traceutil/trace.go:172","msg":"trace[1100098877] range","detail":"{range_begin:/registry/minions/controller; range_end:; response_count:1; response_revision:258; }","duration":"302.230298ms","start":"2026-04-18T17:52:22.496586Z","end":"2026-04-18T17:52:22.798816Z","steps":["trace[1100098877] 'agreement among raft nodes before linearized reading' (duration: 124.083481ms)","trace[1100098877] 'range keys from in-memory index tree' (duration: 177.893189ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:22.798889Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.496573Z","time spent":"302.302459ms","remote":"127.0.0.1:43840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":32,"response count":1,"response size":3618,"request content":"key:\"/registry/minions/controller\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:22.798915Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"178.131346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:22.799024Z","caller":"traceutil/trace.go:172","msg":"trace[459737610] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"302.056842ms","start":"2026-04-18T17:52:22.496959Z","end":"2026-04-18T17:52:22.799016Z","steps":["trace[459737610] 'process raft request' (duration: 302.00204ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.799113Z","caller":"traceutil/trace.go:172","msg":"trace[274418777] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"302.203686ms","start":"2026-04-18T17:52:22.496885Z","end":"2026-04-18T17:52:22.799089Z","steps":["trace[274418777] 'process raft request' (duration: 123.859283ms)","trace[274418777] 'compare' (duration: 177.949551ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:22.799242Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.496874Z","time spent":"302.32795ms","remote":"127.0.0.1:43632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":707,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:52:22.799253Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.496951Z","time spent":"302.088973ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:22.801035Z","caller":"traceutil/trace.go:172","msg":"trace[18380207] linearizableReadLoop","detail":"{readStateIndex:270; appliedIndex:270; }","duration":"180.375375ms","start":"2026-04-18T17:52:22.620643Z","end":"2026-04-18T17:52:22.801019Z","steps":["trace[18380207] 'read index received' (duration: 180.369635ms)","trace[18380207] 'applied index is now lower than readState.Index' (duration: 4.82µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:22.801422Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"271.196352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-04-18T17:52:22.801457Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.109923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:22.801483Z","caller":"traceutil/trace.go:172","msg":"trace[1101493944] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:260; }","duration":"271.259334ms","start":"2026-04-18T17:52:22.530208Z","end":"2026-04-18T17:52:22.801468Z","steps":["trace[1101493944] 'agreement among raft nodes before linearized reading' (duration: 271.104239ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.801495Z","caller":"traceutil/trace.go:172","msg":"trace[329414539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:262; }","duration":"106.150164ms","start":"2026-04-18T17:52:22.695335Z","end":"2026-04-18T17:52:22.801485Z","steps":["trace[329414539] 'agreement among raft nodes before linearized reading' (duration: 106.091482ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.801741Z","caller":"traceutil/trace.go:172","msg":"trace[1136289936] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"271.655735ms","start":"2026-04-18T17:52:22.530067Z","end":"2026-04-18T17:52:22.801723Z","steps":["trace[1136289936] 'process raft request' (duration: 271.264643ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:22.801761Z","caller":"traceutil/trace.go:172","msg":"trace[1027434982] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"269.854741ms","start":"2026-04-18T17:52:22.531884Z","end":"2026-04-18T17:52:22.801739Z","steps":["trace[1027434982] 'process raft request' (duration: 269.50854ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:23.090773Z","caller":"traceutil/trace.go:172","msg":"trace[1461369685] linearizableReadLoop","detail":"{readStateIndex:273; appliedIndex:273; }","duration":"210.325007ms","start":"2026-04-18T17:52:22.880368Z","end":"2026-04-18T17:52:23.090693Z","steps":["trace[1461369685] 'read index received' (duration: 210.297626ms)","trace[1461369685] 'applied index is now lower than readState.Index' (duration: 24.081µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:23.340986Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"460.595961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:23.341101Z","caller":"traceutil/trace.go:172","msg":"trace[2069119084] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:0; response_revision:263; }","duration":"460.714085ms","start":"2026-04-18T17:52:22.880351Z","end":"2026-04-18T17:52:23.341065Z","steps":["trace[2069119084] 'agreement among raft nodes before linearized reading' (duration: 210.524722ms)","trace[2069119084] 'range keys from in-memory index tree' (duration: 250.022198ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:23.341171Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.880329Z","time spent":"460.824689ms","remote":"127.0.0.1:43888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:23.341732Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"250.884473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:23.341912Z","caller":"traceutil/trace.go:172","msg":"trace[195375672] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"531.854492ms","start":"2026-04-18T17:52:22.810040Z","end":"2026-04-18T17:52:23.341895Z","steps":["trace[195375672] 'process raft request' (duration: 531.763579ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:23.341909Z","caller":"traceutil/trace.go:172","msg":"trace[1902955888] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"533.948246ms","start":"2026-04-18T17:52:22.807938Z","end":"2026-04-18T17:52:23.341886Z","steps":["trace[1902955888] 'process raft request' (duration: 282.818475ms)","trace[1902955888] 'compare' (duration: 250.641916ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:23.342018Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.810018Z","time spent":"531.948975ms","remote":"127.0.0.1:43840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3846,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:52:23.342089Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:22.807925Z","time spent":"534.110271ms","remote":"127.0.0.1:43708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2123,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:52:23.426380Z","caller":"traceutil/trace.go:172","msg":"trace[1431031457] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:275; }","duration":"335.392848ms","start":"2026-04-18T17:52:23.090958Z","end":"2026-04-18T17:52:23.426350Z","steps":["trace[1431031457] 'read index received' (duration: 335.381137ms)","trace[1431031457] 'applied index is now lower than readState.Index' (duration: 10.571µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:23.426574Z","caller":"traceutil/trace.go:172","msg":"trace[2007396549] transaction","detail":"{read_only:false; number_of_response:0; response_revision:265; }","duration":"411.121254ms","start":"2026-04-18T17:52:23.015414Z","end":"2026-04-18T17:52:23.426536Z","steps":["trace[2007396549] 'process raft request' (duration: 411.009101ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:23.426638Z","caller":"traceutil/trace.go:172","msg":"trace[211560289] transaction","detail":"{read_only:false; number_of_response:0; response_revision:265; }","duration":"409.211927ms","start":"2026-04-18T17:52:23.017327Z","end":"2026-04-18T17:52:23.426539Z","steps":["trace[211560289] 'process raft request' (duration: 409.175615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.426686Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"412.516907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-controller\" limit:1 ","response":"range_response_count:1 size:3174"} {"level":"info","ts":"2026-04-18T17:52:23.426700Z","caller":"traceutil/trace.go:172","msg":"trace[2130519965] transaction","detail":"{read_only:false; number_of_response:0; response_revision:265; }","duration":"410.98535ms","start":"2026-04-18T17:52:23.015667Z","end":"2026-04-18T17:52:23.426653Z","steps":["trace[2130519965] 'process raft request' (duration: 410.821455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.426846Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:23.017317Z","time spent":"409.434173ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:52:23.426743Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:23.015396Z","time spent":"411.27766ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:52:23.426893Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:23.015651Z","time spent":"411.158706ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:52:23.426742Z","caller":"traceutil/trace.go:172","msg":"trace[687884869] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-controller; range_end:; response_count:1; response_revision:265; }","duration":"412.589669ms","start":"2026-04-18T17:52:23.014136Z","end":"2026-04-18T17:52:23.426726Z","steps":["trace[687884869] 'agreement among raft nodes before linearized reading' (duration: 412.342502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.427055Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:23.014112Z","time spent":"412.92661ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":3197,"request content":"key:\"/registry/pods/kube-system/kube-vip-controller\" limit:1 "} {"level":"info","ts":"2026-04-18T17:52:23.678094Z","caller":"traceutil/trace.go:172","msg":"trace[1290380091] linearizableReadLoop","detail":"{readStateIndex:278; appliedIndex:278; }","duration":"251.599455ms","start":"2026-04-18T17:52:23.426453Z","end":"2026-04-18T17:52:23.678053Z","steps":["trace[1290380091] 'read index received' (duration: 251.583585ms)","trace[1290380091] 'applied index is now lower than readState.Index' (duration: 13.16µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:23.830968Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"152.798776ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-04-18T17:52:23.831008Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"484.626915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-18T17:52:23.831100Z","caller":"traceutil/trace.go:172","msg":"trace[2051958265] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"480.085087ms","start":"2026-04-18T17:52:23.350996Z","end":"2026-04-18T17:52:23.831081Z","steps":["trace[2051958265] 'process raft request' (duration: 327.107036ms)","trace[2051958265] 'compare' (duration: 152.62421ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:23.831114Z","caller":"traceutil/trace.go:172","msg":"trace[242916335] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:265; }","duration":"484.768609ms","start":"2026-04-18T17:52:23.346317Z","end":"2026-04-18T17:52:23.831085Z","steps":["trace[242916335] 'agreement among raft nodes before linearized reading' (duration: 331.887231ms)","trace[242916335] 'range keys from in-memory index tree' (duration: 152.584749ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:23.831156Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:23.350978Z","time spent":"480.157969ms","remote":"127.0.0.1:44416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2628,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:52:23.831193Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:23.346297Z","time spent":"484.861362ms","remote":"127.0.0.1:43718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"info","ts":"2026-04-18T17:52:23.831749Z","caller":"traceutil/trace.go:172","msg":"trace[1773725886] linearizableReadLoop","detail":"{readStateIndex:279; appliedIndex:279; }","duration":"153.543969ms","start":"2026-04-18T17:52:23.678191Z","end":"2026-04-18T17:52:23.831735Z","steps":["trace[1773725886] 'read index received' (duration: 153.538429ms)","trace[1773725886] 'applied index is now lower than readState.Index' (duration: 4.52µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:23.831919Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"403.71498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-controller\" limit:1 ","response":"range_response_count:1 size:5690"} {"level":"info","ts":"2026-04-18T17:52:23.831955Z","caller":"traceutil/trace.go:172","msg":"trace[76398845] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-controller; range_end:; response_count:1; response_revision:266; }","duration":"403.758721ms","start":"2026-04-18T17:52:23.428187Z","end":"2026-04-18T17:52:23.831945Z","steps":["trace[76398845] 'agreement among raft nodes before linearized reading' (duration: 403.599316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.831983Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:23.428170Z","time spent":"403.804973ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":5713,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-controller\" limit:1 "} {"level":"info","ts":"2026-04-18T17:52:23.831979Z","caller":"traceutil/trace.go:172","msg":"trace[723792046] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"298.411622ms","start":"2026-04-18T17:52:23.533550Z","end":"2026-04-18T17:52:23.831962Z","steps":["trace[723792046] 'process raft request' (duration: 298.35122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.832202Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"403.583436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-controller\" limit:1 ","response":"range_response_count:1 size:6077"} {"level":"info","ts":"2026-04-18T17:52:23.832255Z","caller":"traceutil/trace.go:172","msg":"trace[1239952140] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-controller; range_end:; response_count:1; response_revision:268; }","duration":"403.637597ms","start":"2026-04-18T17:52:23.428609Z","end":"2026-04-18T17:52:23.832246Z","steps":["trace[1239952140] 'agreement among raft nodes before linearized reading' (duration: 403.517074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.832281Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:23.428589Z","time spent":"403.684669ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":6100,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-controller\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:23.832393Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"403.960638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 ","response":"range_response_count:1 size:3323"} {"level":"info","ts":"2026-04-18T17:52:23.832416Z","caller":"traceutil/trace.go:172","msg":"trace[12249161] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-controller; range_end:; response_count:1; response_revision:268; }","duration":"403.982158ms","start":"2026-04-18T17:52:23.428427Z","end":"2026-04-18T17:52:23.832409Z","steps":["trace[12249161] 'agreement among raft nodes before linearized reading' (duration: 403.913646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.832456Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:23.428422Z","time spent":"404.025739ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":3346,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 "} {"level":"info","ts":"2026-04-18T17:52:23.832530Z","caller":"traceutil/trace.go:172","msg":"trace[1062563974] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"378.698077ms","start":"2026-04-18T17:52:23.453782Z","end":"2026-04-18T17:52:23.832480Z","steps":["trace[1062563974] 'process raft request' (duration: 378.014937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:23.832653Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:23.453748Z","time spent":"378.826571ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4542,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:52:25.049228Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"163.553942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" limit:1 ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-04-18T17:52:25.049308Z","caller":"traceutil/trace.go:172","msg":"trace[1800818902] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:294; }","duration":"163.655545ms","start":"2026-04-18T17:52:24.885637Z","end":"2026-04-18T17:52:25.049292Z","steps":["trace[1800818902] 'range keys from in-memory index tree' (duration: 163.369056ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:25.591357Z","caller":"traceutil/trace.go:172","msg":"trace[448474321] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"105.226805ms","start":"2026-04-18T17:52:25.486106Z","end":"2026-04-18T17:52:25.591333Z","steps":["trace[448474321] 'process raft request' (duration: 105.0368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:26.524286Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"542.149763ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:26.524467Z","caller":"traceutil/trace.go:172","msg":"trace[1559544755] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"888.673747ms","start":"2026-04-18T17:52:25.635716Z","end":"2026-04-18T17:52:26.524390Z","steps":["trace[1559544755] 'process raft request' (duration: 346.35946ms)","trace[1559544755] 'compare' (duration: 542.008318ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:26.524921Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.635696Z","time spent":"888.817541ms","remote":"127.0.0.1:43888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":223,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:52:26.897050Z","caller":"traceutil/trace.go:172","msg":"trace[1151599394] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:311; }","duration":"367.454631ms","start":"2026-04-18T17:52:26.529570Z","end":"2026-04-18T17:52:26.897025Z","steps":["trace[1151599394] 'read index received' (duration: 367.44637ms)","trace[1151599394] 'applied index is now lower than readState.Index' (duration: 7.031µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:27.995696Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.466112138s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:27.995790Z","caller":"traceutil/trace.go:172","msg":"trace[798334261] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:0; response_revision:298; }","duration":"1.4662029s","start":"2026-04-18T17:52:26.529556Z","end":"2026-04-18T17:52:27.995759Z","steps":["trace[798334261] 'agreement among raft nodes before linearized reading' (duration: 367.559083ms)","trace[798334261] 'range keys from in-memory index tree' (duration: 1.098524403s)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:27.995833Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:26.529536Z","time spent":"1.466285523s","remote":"127.0.0.1:43888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:52:27.996211Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.099035329s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:27.996323Z","caller":"traceutil/trace.go:172","msg":"trace[326468266] linearizableReadLoop","detail":"{readStateIndex:312; appliedIndex:311; }","duration":"1.099188223s","start":"2026-04-18T17:52:26.897124Z","end":"2026-04-18T17:52:27.996312Z","steps":["trace[326468266] 'read index received' (duration: 355.079194ms)","trace[326468266] 'applied index is now lower than readState.Index' (duration: 744.108299ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:27.996409Z","caller":"traceutil/trace.go:172","msg":"trace[897766680] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"1.183314285s","start":"2026-04-18T17:52:26.813085Z","end":"2026-04-18T17:52:27.996399Z","steps":["trace[897766680] 'process raft request' (duration: 1.183195901s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:27.996458Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:26.813055Z","time spent":"1.183382477s","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:52:27.996528Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"672.924152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 ","response":"range_response_count:1 size:4943"} {"level":"info","ts":"2026-04-18T17:52:27.996561Z","caller":"traceutil/trace.go:172","msg":"trace[264493424] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-controller; range_end:; response_count:1; response_revision:300; }","duration":"672.956493ms","start":"2026-04-18T17:52:27.323597Z","end":"2026-04-18T17:52:27.996553Z","steps":["trace[264493424] 'agreement among raft nodes before linearized reading' (duration: 672.841129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:27.996585Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:27.323572Z","time spent":"673.006373ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":4966,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 "} {"level":"info","ts":"2026-04-18T17:52:27.996421Z","caller":"traceutil/trace.go:172","msg":"trace[1199301091] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"2.156466504s","start":"2026-04-18T17:52:25.839927Z","end":"2026-04-18T17:52:27.996394Z","steps":["trace[1199301091] 'process raft request' (duration: 1.057179257s)","trace[1199301091] 'compare' (duration: 1.098492773s)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:27.996420Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.109944291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:27.996740Z","caller":"traceutil/trace.go:172","msg":"trace[169183085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:300; }","duration":"1.110263321s","start":"2026-04-18T17:52:26.886468Z","end":"2026-04-18T17:52:27.996731Z","steps":["trace[169183085] 'agreement among raft nodes before linearized reading' (duration: 1.109925721s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:27.996739Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:25.839900Z","time spent":"2.156759683s","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:52:27.996768Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:26.886444Z","time spent":"1.110316182s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:52:29.199835Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954130104810966,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:52:29.392357Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.13135295s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:29.393538Z","caller":"traceutil/trace.go:172","msg":"trace[858204618] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"1.391214553s","start":"2026-04-18T17:52:28.002295Z","end":"2026-04-18T17:52:29.393509Z","steps":["trace[858204618] 'process raft request' (duration: 258.658636ms)","trace[858204618] 'compare' (duration: 1.131232697s)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:29.393648Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.002281Z","time spent":"1.391310386s","remote":"127.0.0.1:43888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:52:29.469355Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.208451228s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T17:52:29.469820Z","caller":"traceutil/trace.go:172","msg":"trace[151238542] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:314; }","duration":"770.525722ms","start":"2026-04-18T17:52:28.699253Z","end":"2026-04-18T17:52:29.469778Z","steps":["trace[151238542] 'read index received' (duration: 770.511832ms)","trace[151238542] 'applied index is now lower than readState.Index' (duration: 11.67µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:29.469940Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"770.662966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:29.469986Z","caller":"traceutil/trace.go:172","msg":"trace[832759485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:301; }","duration":"770.723058ms","start":"2026-04-18T17:52:28.699247Z","end":"2026-04-18T17:52:29.469970Z","steps":["trace[832759485] 'agreement among raft nodes before linearized reading' (duration: 770.623545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:29.470016Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.699220Z","time spent":"770.79017ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-18T17:52:29.470025Z","caller":"traceutil/trace.go:172","msg":"trace[1798304569] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"1.466216907s","start":"2026-04-18T17:52:28.003788Z","end":"2026-04-18T17:52:29.470005Z","steps":["trace[1798304569] 'process raft request' (duration: 1.466053262s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:29.470225Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.003758Z","time spent":"1.46631604s","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4928,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:29.474003Z","caller":"traceutil/trace.go:172","msg":"trace[667536428] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"1.20164158s","start":"2026-04-18T17:52:28.272338Z","end":"2026-04-18T17:52:29.473980Z","steps":["trace[667536428] 'process raft request' (duration: 1.201382762s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:29.474145Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:28.272309Z","time spent":"1.201761984s","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:52:30.319733Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"283.11507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:30.319866Z","caller":"traceutil/trace.go:172","msg":"trace[1281490738] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:368; }","duration":"192.180831ms","start":"2026-04-18T17:52:30.127667Z","end":"2026-04-18T17:52:30.319848Z","steps":["trace[1281490738] 'read index received' (duration: 61.512µs)","trace[1281490738] 'applied index is now lower than readState.Index' (duration: 192.118249ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:52:30.320037Z","caller":"traceutil/trace.go:172","msg":"trace[1812926374] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"318.139807ms","start":"2026-04-18T17:52:30.001839Z","end":"2026-04-18T17:52:30.319979Z","steps":["trace[1812926374] 'process raft request' (duration: 34.697177ms)","trace[1812926374] 'compare' (duration: 282.963176ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:30.320447Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:30.001795Z","time spent":"318.469907ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:52:30.320124Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"192.451809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-controller\" limit:1 ","response":"range_response_count:1 size:7355"} {"level":"info","ts":"2026-04-18T17:52:30.320772Z","caller":"traceutil/trace.go:172","msg":"trace[1967714660] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-controller; range_end:; response_count:1; response_revision:356; }","duration":"193.093849ms","start":"2026-04-18T17:52:30.127659Z","end":"2026-04-18T17:52:30.320753Z","steps":["trace[1967714660] 'agreement among raft nodes before linearized reading' (duration: 192.313135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:30.320154Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"140.937061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-18T17:52:30.320877Z","caller":"traceutil/trace.go:172","msg":"trace[1303695490] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:356; }","duration":"141.671363ms","start":"2026-04-18T17:52:30.179189Z","end":"2026-04-18T17:52:30.320860Z","steps":["trace[1303695490] 'agreement among raft nodes before linearized reading' (duration: 140.816067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:30.594209Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"167.937313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:52:30.594540Z","caller":"traceutil/trace.go:172","msg":"trace[1615332116] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"256.810569ms","start":"2026-04-18T17:52:30.337698Z","end":"2026-04-18T17:52:30.594508Z","steps":["trace[1615332116] 'process raft request' (duration: 256.700205ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:30.594667Z","caller":"traceutil/trace.go:172","msg":"trace[1731273024] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"265.761222ms","start":"2026-04-18T17:52:30.328874Z","end":"2026-04-18T17:52:30.594635Z","steps":["trace[1731273024] 'process raft request' (duration: 97.244461ms)","trace[1731273024] 'compare' (duration: 167.709446ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:36.111790Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.414297869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:36.111868Z","caller":"traceutil/trace.go:172","msg":"trace[1779767858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:372; }","duration":"1.414389251s","start":"2026-04-18T17:52:34.697463Z","end":"2026-04-18T17:52:36.111853Z","steps":["trace[1779767858] 'range keys from in-memory index tree' (duration: 1.414198406s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:36.111792Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"938.709373ms","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-04-18T17:52:36.111904Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:34.697439Z","time spent":"1.414457464s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:52:36.111909Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.634584112s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:36.111954Z","caller":"traceutil/trace.go:172","msg":"trace[373427441] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:372; }","duration":"938.877008ms","start":"2026-04-18T17:52:35.173052Z","end":"2026-04-18T17:52:36.111929Z","steps":["trace[373427441] 'range keys from in-memory index tree' (duration: 938.64964ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:36.111999Z","caller":"traceutil/trace.go:172","msg":"trace[411024629] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:372; }","duration":"1.634703525s","start":"2026-04-18T17:52:34.477278Z","end":"2026-04-18T17:52:36.111982Z","steps":["trace[411024629] 'range keys from in-memory index tree' (duration: 1.634461069s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:36.143129Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"319.868337ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-18T17:52:38.564091Z","caller":"traceutil/trace.go:172","msg":"trace[801719934] linearizableReadLoop","detail":"{readStateIndex:391; appliedIndex:391; }","duration":"118.145455ms","start":"2026-04-18T17:52:38.445921Z","end":"2026-04-18T17:52:38.564066Z","steps":["trace[801719934] 'read index received' (duration: 118.137635ms)","trace[801719934] 'applied index is now lower than readState.Index' (duration: 6.61µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:38.564250Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"118.347112ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:38.564291Z","caller":"traceutil/trace.go:172","msg":"trace[881702572] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:375; }","duration":"118.404683ms","start":"2026-04-18T17:52:38.445875Z","end":"2026-04-18T17:52:38.564279Z","steps":["trace[881702572] 'agreement among raft nodes before linearized reading' (duration: 118.314681ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:38.564857Z","caller":"traceutil/trace.go:172","msg":"trace[867040917] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"161.264548ms","start":"2026-04-18T17:52:38.403583Z","end":"2026-04-18T17:52:38.564847Z","steps":["trace[867040917] 'process raft request' (duration: 161.156314ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:42.731110Z","caller":"traceutil/trace.go:172","msg":"trace[398361729] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:397; }","duration":"285.784024ms","start":"2026-04-18T17:52:42.445299Z","end":"2026-04-18T17:52:42.731083Z","steps":["trace[398361729] 'read index received' (duration: 285.773114ms)","trace[398361729] 'applied index is now lower than readState.Index' (duration: 9.15µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:52:42.731296Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"285.97325ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:52:42.731421Z","caller":"traceutil/trace.go:172","msg":"trace[1876478883] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:380; }","duration":"286.099134ms","start":"2026-04-18T17:52:42.445285Z","end":"2026-04-18T17:52:42.731385Z","steps":["trace[1876478883] 'agreement among raft nodes before linearized reading' (duration: 285.926489ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:52:42.731489Z","caller":"traceutil/trace.go:172","msg":"trace[119028117] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"536.301696ms","start":"2026-04-18T17:52:42.195173Z","end":"2026-04-18T17:52:42.731474Z","steps":["trace[119028117] 'process raft request' (duration: 536.138221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:42.731648Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:52:42.195151Z","time spent":"536.388729ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:52:42.733216Z","caller":"traceutil/trace.go:172","msg":"trace[1338483808] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"152.125787ms","start":"2026-04-18T17:52:42.581065Z","end":"2026-04-18T17:52:42.733191Z","steps":["trace[1338483808] 'process raft request' (duration: 151.954782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:52:45.523562Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"122.241278ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-18T17:53:03.007820Z","caller":"traceutil/trace.go:172","msg":"trace[1601243895] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"144.362809ms","start":"2026-04-18T17:53:02.863426Z","end":"2026-04-18T17:53:03.007789Z","steps":["trace[1601243895] 'process raft request' (duration: 143.898875ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:03.023666Z","caller":"traceutil/trace.go:172","msg":"trace[1879438785] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"140.003296ms","start":"2026-04-18T17:53:02.883640Z","end":"2026-04-18T17:53:03.023643Z","steps":["trace[1879438785] 'process raft request' (duration: 139.847731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.044907Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"599.932753ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:08.044978Z","caller":"traceutil/trace.go:172","msg":"trace[704854760] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:487; }","duration":"600.039317ms","start":"2026-04-18T17:53:07.444928Z","end":"2026-04-18T17:53:08.044967Z","steps":["trace[704854760] 'range keys from in-memory index tree' (duration: 599.874042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.045356Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"444.618563ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:53:08.045494Z","caller":"traceutil/trace.go:172","msg":"trace[1764394806] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"852.804099ms","start":"2026-04-18T17:53:07.192678Z","end":"2026-04-18T17:53:08.045482Z","steps":["trace[1764394806] 'process raft request' (duration: 852.751738ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:08.045538Z","caller":"traceutil/trace.go:172","msg":"trace[1934729738] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"853.729267ms","start":"2026-04-18T17:53:07.191784Z","end":"2026-04-18T17:53:08.045514Z","steps":["trace[1934729738] 'process raft request' (duration: 408.908478ms)","trace[1934729738] 'compare' (duration: 444.274623ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:08.045833Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.191766Z","time spent":"854.024486ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:53:08.045568Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.192668Z","time spent":"852.875181ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:53:08.068934Z","caller":"traceutil/trace.go:172","msg":"trace[370125354] linearizableReadLoop","detail":"{readStateIndex:516; appliedIndex:516; }","duration":"369.858341ms","start":"2026-04-18T17:53:07.699047Z","end":"2026-04-18T17:53:08.068906Z","steps":["trace[370125354] 'read index received' (duration: 369.847961ms)","trace[370125354] 'applied index is now lower than readState.Index' (duration: 9.09µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:53:08.069241Z","caller":"traceutil/trace.go:172","msg":"trace[2102107920] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"871.585979ms","start":"2026-04-18T17:53:07.197622Z","end":"2026-04-18T17:53:08.069208Z","steps":["trace[2102107920] 'process raft request' (duration: 871.402134ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:08.069343Z","caller":"traceutil/trace.go:172","msg":"trace[2045370730] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"875.257851ms","start":"2026-04-18T17:53:07.194015Z","end":"2026-04-18T17:53:08.069273Z","steps":["trace[2045370730] 'process raft request' (duration: 874.863209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.069439Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.197613Z","time spent":"871.689973ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:53:08.069472Z","caller":"traceutil/trace.go:172","msg":"trace[876680080] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"873.370654ms","start":"2026-04-18T17:53:07.196088Z","end":"2026-04-18T17:53:08.069459Z","steps":["trace[876680080] 'process raft request' (duration: 872.893249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.069527Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.196079Z","time spent":"873.424385ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:53:08.069532Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.194006Z","time spent":"875.430716ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:53:08.069621Z","caller":"traceutil/trace.go:172","msg":"trace[759635560] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"863.761432ms","start":"2026-04-18T17:53:07.205846Z","end":"2026-04-18T17:53:08.069607Z","steps":["trace[759635560] 'process raft request' (duration: 863.245256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.069706Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.205834Z","time spent":"863.819904ms","remote":"127.0.0.1:43604","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-04-18T17:53:08.069862Z","caller":"traceutil/trace.go:172","msg":"trace[1753177748] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"862.083151ms","start":"2026-04-18T17:53:07.207730Z","end":"2026-04-18T17:53:08.069814Z","steps":["trace[1753177748] 'process raft request' (duration: 861.39124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.069105Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"370.044727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:08.069945Z","caller":"traceutil/trace.go:172","msg":"trace[654719186] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"870.704913ms","start":"2026-04-18T17:53:07.199219Z","end":"2026-04-18T17:53:08.069924Z","steps":["trace[654719186] 'process raft request' (duration: 869.840027ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:08.069961Z","caller":"traceutil/trace.go:172","msg":"trace[495232279] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"854.172741ms","start":"2026-04-18T17:53:07.215772Z","end":"2026-04-18T17:53:08.069945Z","steps":["trace[495232279] 'process raft request' (duration: 853.396607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.070692Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.215750Z","time spent":"854.911983ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:53:08.069968Z","caller":"traceutil/trace.go:172","msg":"trace[1407828564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:492; }","duration":"370.920653ms","start":"2026-04-18T17:53:07.699035Z","end":"2026-04-18T17:53:08.069956Z","steps":["trace[1407828564] 'agreement among raft nodes before linearized reading' (duration: 370.004495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.070863Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.699020Z","time spent":"371.82828ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:53:08.070005Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.207705Z","time spent":"862.224165ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:53:08.070023Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.199204Z","time spent":"870.786535ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:53:08.070103Z","caller":"traceutil/trace.go:172","msg":"trace[1697896164] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"813.547386ms","start":"2026-04-18T17:53:07.256549Z","end":"2026-04-18T17:53:08.070096Z","steps":["trace[1697896164] 'process raft request' (duration: 812.663339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.071033Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.256519Z","time spent":"814.486915ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:53:08.070216Z","caller":"traceutil/trace.go:172","msg":"trace[1487273918] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"726.1491ms","start":"2026-04-18T17:53:07.344057Z","end":"2026-04-18T17:53:08.070206Z","steps":["trace[1487273918] 'process raft request' (duration: 725.315224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.072557Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:07.344026Z","time spent":"727.172971ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:53:08.699169Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"253.761082ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:08.699264Z","caller":"traceutil/trace.go:172","msg":"trace[986657547] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:519; }","duration":"253.887846ms","start":"2026-04-18T17:53:08.445356Z","end":"2026-04-18T17:53:08.699244Z","steps":["trace[986657547] 'range keys from in-memory index tree' (duration: 253.67361ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:08.699265Z","caller":"traceutil/trace.go:172","msg":"trace[67864400] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"437.364912ms","start":"2026-04-18T17:53:08.261872Z","end":"2026-04-18T17:53:08.699237Z","steps":["trace[67864400] 'process raft request' (duration: 431.946197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.699390Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:08.261851Z","time spent":"437.468005ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:53:08.700372Z","caller":"traceutil/trace.go:172","msg":"trace[1770937595] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"425.940475ms","start":"2026-04-18T17:53:08.274418Z","end":"2026-04-18T17:53:08.700359Z","steps":["trace[1770937595] 'process raft request' (duration: 425.726958ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:08.700352Z","caller":"traceutil/trace.go:172","msg":"trace[1892029790] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"377.484592ms","start":"2026-04-18T17:53:08.322845Z","end":"2026-04-18T17:53:08.700330Z","steps":["trace[1892029790] 'process raft request' (duration: 377.434861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:08.700761Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:08.322816Z","time spent":"377.854353ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:53:08.700546Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:08.274398Z","time spent":"426.005707ms","remote":"127.0.0.1:43604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:53:13.995602Z","caller":"traceutil/trace.go:172","msg":"trace[905520379] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"103.04108ms","start":"2026-04-18T17:53:13.892536Z","end":"2026-04-18T17:53:13.995577Z","steps":["trace[905520379] 'process raft request' (duration: 102.564045ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:14.652619Z","caller":"traceutil/trace.go:172","msg":"trace[676018543] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"190.400466ms","start":"2026-04-18T17:53:14.462188Z","end":"2026-04-18T17:53:14.652588Z","steps":["trace[676018543] 'process raft request' (duration: 189.357934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:15.364539Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"190.580662ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:15.364631Z","caller":"traceutil/trace.go:172","msg":"trace[759933028] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:578; }","duration":"190.675725ms","start":"2026-04-18T17:53:15.173935Z","end":"2026-04-18T17:53:15.364611Z","steps":["trace[759933028] 'range keys from in-memory index tree' (duration: 190.53501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:15.364761Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"623.101014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:53:15.365414Z","caller":"traceutil/trace.go:172","msg":"trace[757227928] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"651.394564ms","start":"2026-04-18T17:53:14.713999Z","end":"2026-04-18T17:53:15.365394Z","steps":["trace[757227928] 'process raft request' (duration: 27.538857ms)","trace[757227928] 'compare' (duration: 622.772285ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:15.365495Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:14.713980Z","time spent":"651.468527ms","remote":"127.0.0.1:44490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:53:15.667357Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954130104811551,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T17:53:15.978350Z","caller":"traceutil/trace.go:172","msg":"trace[366382324] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:607; }","duration":"811.289753ms","start":"2026-04-18T17:53:15.167026Z","end":"2026-04-18T17:53:15.978315Z","steps":["trace[366382324] 'read index received' (duration: 811.277182ms)","trace[366382324] 'applied index is now lower than readState.Index' (duration: 10.581µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:16.105217Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"937.915321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bm47c\" limit:1 ","response":"range_response_count:1 size:18345"} {"level":"info","ts":"2026-04-18T17:53:16.105332Z","caller":"traceutil/trace.go:172","msg":"trace[691160728] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bm47c; range_end:; response_count:1; response_revision:579; }","duration":"938.298242ms","start":"2026-04-18T17:53:15.167012Z","end":"2026-04-18T17:53:16.105310Z","steps":["trace[691160728] 'agreement among raft nodes before linearized reading' (duration: 811.395946ms)","trace[691160728] 'range keys from in-memory index tree' (duration: 126.268238ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:16.105456Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"126.980289ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-18T17:53:16.105373Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:15.166989Z","time spent":"938.372365ms","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18368,"request content":"key:\"/registry/pods/kube-system/cilium-bm47c\" limit:1 "} {"level":"info","ts":"2026-04-18T17:53:16.105640Z","caller":"traceutil/trace.go:172","msg":"trace[1800170566] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.018470459s","start":"2026-04-18T17:53:15.087155Z","end":"2026-04-18T17:53:16.105626Z","steps":["trace[1800170566] 'process raft request' (duration: 1.018421687s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:16.105639Z","caller":"traceutil/trace.go:172","msg":"trace[1907215161] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"127.200426ms","start":"2026-04-18T17:53:15.978423Z","end":"2026-04-18T17:53:16.105624Z","steps":["trace[1907215161] 'read index received' (duration: 54.703562ms)","trace[1907215161] 'applied index is now lower than readState.Index' (duration: 72.495074ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:16.105729Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:15.087115Z","time spent":"1.018561591s","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:53:16.105638Z","caller":"traceutil/trace.go:172","msg":"trace[648010666] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.028215235s","start":"2026-04-18T17:53:15.077381Z","end":"2026-04-18T17:53:16.105597Z","steps":["trace[648010666] 'process raft request' (duration: 901.016069ms)","trace[648010666] 'compare' (duration: 126.825815ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:16.106011Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:15.077361Z","time spent":"1.028555895s","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:53:16.106248Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"699.093153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:16.106290Z","caller":"traceutil/trace.go:172","msg":"trace[840180162] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:581; }","duration":"699.134735ms","start":"2026-04-18T17:53:15.407144Z","end":"2026-04-18T17:53:16.106279Z","steps":["trace[840180162] 'agreement among raft nodes before linearized reading' (duration: 699.075253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:16.106322Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:15.407123Z","time spent":"699.188327ms","remote":"127.0.0.1:43928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:53:16.105883Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"406.75396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:16.106686Z","caller":"traceutil/trace.go:172","msg":"trace[573466190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"407.570755ms","start":"2026-04-18T17:53:15.699088Z","end":"2026-04-18T17:53:16.106658Z","steps":["trace[573466190] 'agreement among raft nodes before linearized reading' (duration: 406.702169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:16.106749Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:15.699059Z","time spent":"407.674698ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:53:16.109933Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"664.580085ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:16.110151Z","caller":"traceutil/trace.go:172","msg":"trace[2125741686] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:581; }","duration":"664.782521ms","start":"2026-04-18T17:53:15.445301Z","end":"2026-04-18T17:53:16.110084Z","steps":["trace[2125741686] 'agreement among raft nodes before linearized reading' (duration: 660.45409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:16.946774Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954130104811558,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:53:17.447241Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954130104811558,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:53:17.947952Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954130104811558,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:53:18.448724Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954130104811558,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:53:18.699658Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000258409s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-18T17:53:18.699738Z","caller":"traceutil/trace.go:172","msg":"trace[1977533297] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000350651s","start":"2026-04-18T17:53:16.699370Z","end":"2026-04-18T17:53:18.699721Z","steps":["trace[1977533297] 'agreement among raft nodes before linearized reading' (duration: 2.000255888s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:18.699785Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:16.699353Z","time spent":"2.000424004s","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/18 17:53:18 WARNING: [core] [Server #6]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-18T17:53:18.949142Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954130104811558,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:53:19.242741Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"3.106026909s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T17:53:19.242955Z","caller":"traceutil/trace.go:172","msg":"trace[761514028] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:610; }","duration":"2.797294388s","start":"2026-04-18T17:53:16.445635Z","end":"2026-04-18T17:53:19.242929Z","steps":["trace[761514028] 'read index received' (duration: 2.797285148s)","trace[761514028] 'applied index is now lower than readState.Index' (duration: 7.42µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:19.243072Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.797473803s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:19.243101Z","caller":"traceutil/trace.go:172","msg":"trace[1959671339] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:581; }","duration":"2.797517975s","start":"2026-04-18T17:53:16.445574Z","end":"2026-04-18T17:53:19.243092Z","steps":["trace[1959671339] 'agreement among raft nodes before linearized reading' (duration: 2.797451313s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:19.243296Z","caller":"traceutil/trace.go:172","msg":"trace[978101816] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"3.115468295s","start":"2026-04-18T17:53:16.127808Z","end":"2026-04-18T17:53:19.243276Z","steps":["trace[978101816] 'process raft request' (duration: 3.11529386s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:19.243421Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:16.127779Z","time spent":"3.115576559s","remote":"127.0.0.1:43858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18502,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:53:19.650441Z","caller":"traceutil/trace.go:172","msg":"trace[703173564] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:611; }","duration":"407.418609ms","start":"2026-04-18T17:53:19.243001Z","end":"2026-04-18T17:53:19.650419Z","steps":["trace[703173564] 'read index received' (duration: 407.409479ms)","trace[703173564] 'applied index is now lower than readState.Index' (duration: 7.81µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:19.650601Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"511.964756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:19.650627Z","caller":"traceutil/trace.go:172","msg":"trace[190921734] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations; range_end:; response_count:0; response_revision:582; }","duration":"512.007917ms","start":"2026-04-18T17:53:19.138611Z","end":"2026-04-18T17:53:19.650619Z","steps":["trace[190921734] 'agreement among raft nodes before linearized reading' (duration: 511.927925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:19.650653Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:19.138594Z","time spent":"512.053618ms","remote":"127.0.0.1:44490","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":"warn","ts":"2026-04-18T17:53:19.650880Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.777767018s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:53:19.650836Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"950.944005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:19.650921Z","caller":"traceutil/trace.go:172","msg":"trace[73814428] range","detail":"{range_begin:/registry/prioritylevelconfigurations; range_end:; response_count:0; response_revision:582; }","duration":"1.777797619s","start":"2026-04-18T17:53:17.873106Z","end":"2026-04-18T17:53:19.650904Z","steps":["trace[73814428] 'agreement among raft nodes before linearized reading' (duration: 1.777752298s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:19.650940Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:17.873086Z","time spent":"1.777848751s","remote":"127.0.0.1:44384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/prioritylevelconfigurations\" limit:1 "} {"level":"info","ts":"2026-04-18T17:53:19.650959Z","caller":"traceutil/trace.go:172","msg":"trace[81864833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"951.076629ms","start":"2026-04-18T17:53:18.699850Z","end":"2026-04-18T17:53:19.650927Z","steps":["trace[81864833] 'agreement among raft nodes before linearized reading' (duration: 950.851912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:19.651008Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:18.699833Z","time spent":"951.164331ms","remote":"127.0.0.1:43470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-18T17:53:19.651395Z","caller":"traceutil/trace.go:172","msg":"trace[1720640319] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"3.133116581s","start":"2026-04-18T17:53:16.518258Z","end":"2026-04-18T17:53:19.651374Z","steps":["trace[1720640319] 'process raft request' (duration: 3.132325697s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:19.651434Z","caller":"traceutil/trace.go:172","msg":"trace[1895444980] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.537474937s","start":"2026-04-18T17:53:18.113929Z","end":"2026-04-18T17:53:19.651404Z","steps":["trace[1895444980] 'process raft request' (duration: 1.537311192s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:19.651524Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"407.159211ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:19.651556Z","caller":"traceutil/trace.go:172","msg":"trace[187511123] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:585; }","duration":"407.297346ms","start":"2026-04-18T17:53:19.244251Z","end":"2026-04-18T17:53:19.651549Z","steps":["trace[187511123] 'agreement among raft nodes before linearized reading' (duration: 407.143651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:19.651520Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"865.296892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:53:19.651571Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:18.113894Z","time spent":"1.537603581s","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:53:19.651590Z","caller":"traceutil/trace.go:172","msg":"trace[987642550] range","detail":"{range_begin:/registry/validatingadmissionpolicies; range_end:; response_count:0; response_revision:585; }","duration":"865.372854ms","start":"2026-04-18T17:53:18.786204Z","end":"2026-04-18T17:53:19.651577Z","steps":["trace[987642550] 'agreement among raft nodes before linearized reading' (duration: 865.265321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:19.651623Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:18.786182Z","time spent":"865.432516ms","remote":"127.0.0.1:44506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/validatingadmissionpolicies\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:53:19.651679Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"742.944284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:37 size:3061"} {"level":"info","ts":"2026-04-18T17:53:19.651665Z","caller":"traceutil/trace.go:172","msg":"trace[1435007856] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.537061984s","start":"2026-04-18T17:53:18.114577Z","end":"2026-04-18T17:53:19.651639Z","steps":["trace[1435007856] 'process raft request' (duration: 1.536775706s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:19.651865Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:18.114551Z","time spent":"1.537203579s","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:53:19.651721Z","caller":"traceutil/trace.go:172","msg":"trace[2143576855] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:37; response_revision:583; }","duration":"742.989125ms","start":"2026-04-18T17:53:18.908719Z","end":"2026-04-18T17:53:19.651708Z","steps":["trace[2143576855] 'agreement among raft nodes before linearized reading' (duration: 742.548872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:19.654573Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:18.908692Z","time spent":"745.846542ms","remote":"127.0.0.1:43632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":37,"response size":3084,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true "} {"level":"warn","ts":"2026-04-18T17:53:19.651524Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:16.518229Z","time spent":"3.133222815s","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:53:20.353715Z","caller":"traceutil/trace.go:172","msg":"trace[558377596] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"132.747073ms","start":"2026-04-18T17:53:20.220911Z","end":"2026-04-18T17:53:20.353658Z","steps":["trace[558377596] 'process raft request' (duration: 132.686341ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:20.354191Z","caller":"traceutil/trace.go:172","msg":"trace[168653904] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"169.50092ms","start":"2026-04-18T17:53:20.184250Z","end":"2026-04-18T17:53:20.353750Z","steps":["trace[168653904] 'process raft request' (duration: 169.213531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:21.555250Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.319162ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:21.555380Z","caller":"traceutil/trace.go:172","msg":"trace[1598871465] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:605; }","duration":"110.478247ms","start":"2026-04-18T17:53:21.444878Z","end":"2026-04-18T17:53:21.555356Z","steps":["trace[1598871465] 'range keys from in-memory index tree' (duration: 109.076854ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:23.343567Z","caller":"traceutil/trace.go:172","msg":"trace[680285611] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"114.242011ms","start":"2026-04-18T17:53:23.229308Z","end":"2026-04-18T17:53:23.343550Z","steps":["trace[680285611] 'process raft request' (duration: 114.2001ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:23.343646Z","caller":"traceutil/trace.go:172","msg":"trace[1832231673] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"117.969484ms","start":"2026-04-18T17:53:23.225645Z","end":"2026-04-18T17:53:23.343614Z","steps":["trace[1832231673] 'process raft request' (duration: 64.817639ms)","trace[1832231673] 'compare' (duration: 52.962369ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:24.558660Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"113.076866ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:24.558744Z","caller":"traceutil/trace.go:172","msg":"trace[496631297] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:626; }","duration":"113.170068ms","start":"2026-04-18T17:53:24.445557Z","end":"2026-04-18T17:53:24.558727Z","steps":["trace[496631297] 'range keys from in-memory index tree' (duration: 112.478437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:27.511775Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36158","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:29.446556Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"114.500178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" limit:1 ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-04-18T17:53:29.446654Z","caller":"traceutil/trace.go:172","msg":"trace[1185222590] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:684; }","duration":"114.631412ms","start":"2026-04-18T17:53:29.331997Z","end":"2026-04-18T17:53:29.446629Z","steps":["trace[1185222590] 'agreement among raft nodes before linearized reading' (duration: 73.192983ms)","trace[1185222590] 'range keys from in-memory index tree' (duration: 41.115069ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:53:29.446706Z","caller":"traceutil/trace.go:172","msg":"trace[713429299] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"136.235699ms","start":"2026-04-18T17:53:29.310422Z","end":"2026-04-18T17:53:29.446658Z","steps":["trace[713429299] 'process raft request' (duration: 94.7995ms)","trace[713429299] 'compare' (duration: 41.164861ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:29.710498Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36190","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:29.831876Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36220","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:29.888795Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36244","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:29.926602Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36256","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.040856Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36266","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.119612Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36280","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.207308Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36324","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.229151Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36340","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.249273Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36368","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.292989Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36372","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.316328Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36388","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.336526Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36400","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.352850Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36416","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.363755Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36420","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.403893Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36448","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.435025Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36476","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.460226Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36500","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.487645Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36518","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.502670Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36542","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.515958Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36562","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.530101Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36576","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.541380Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36598","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.560795Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36634","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.569966Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36644","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.583181Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36648","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.596166Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36664","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.612630Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36702","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.625637Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36712","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.638604Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36726","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:30.653125Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36762","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:31.718956Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59524","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:31.747384Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59550","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:39.868564Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954130104812029,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:53:40.369237Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954130104812029,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:53:40.447310Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.135658358s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T17:53:40.447551Z","caller":"traceutil/trace.go:172","msg":"trace[975067849] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:790; }","duration":"1.079067149s","start":"2026-04-18T17:53:39.368457Z","end":"2026-04-18T17:53:40.447524Z","steps":["trace[975067849] 'read index received' (duration: 1.079056999s)","trace[975067849] 'applied index is now lower than readState.Index' (duration: 8.38µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:53:40.447741Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.079259765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:40.447816Z","caller":"traceutil/trace.go:172","msg":"trace[2093072375] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:754; }","duration":"1.079351317s","start":"2026-04-18T17:53:39.368451Z","end":"2026-04-18T17:53:40.447802Z","steps":["trace[2093072375] 'agreement among raft nodes before linearized reading' (duration: 1.079191333s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:40.447819Z","caller":"traceutil/trace.go:172","msg":"trace[1495761442] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"1.136302887s","start":"2026-04-18T17:53:39.311502Z","end":"2026-04-18T17:53:40.447805Z","steps":["trace[1495761442] 'process raft request' (duration: 1.136185364s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:40.447855Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:39.368424Z","time spent":"1.07942087s","remote":"127.0.0.1:43760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:53:40.447921Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:39.311474Z","time spent":"1.13638016s","remote":"127.0.0.1:43928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2879,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:53:40.448556Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.003595246s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:40.448609Z","caller":"traceutil/trace.go:172","msg":"trace[488862929] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:755; }","duration":"1.003651568s","start":"2026-04-18T17:53:39.444946Z","end":"2026-04-18T17:53:40.448597Z","steps":["trace[488862929] 'agreement among raft nodes before linearized reading' (duration: 1.003564046s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:40.448640Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"425.775053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-18T17:53:40.448680Z","caller":"traceutil/trace.go:172","msg":"trace[1794708951] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:755; }","duration":"425.820415ms","start":"2026-04-18T17:53:40.022849Z","end":"2026-04-18T17:53:40.448669Z","steps":["trace[1794708951] 'agreement among raft nodes before linearized reading' (duration: 425.67667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:40.448708Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:40.022828Z","time spent":"425.872197ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:53:40.448933Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"265.713341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-18T17:53:40.449141Z","caller":"traceutil/trace.go:172","msg":"trace[189781363] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:757; }","duration":"265.916648ms","start":"2026-04-18T17:53:40.183212Z","end":"2026-04-18T17:53:40.449128Z","steps":["trace[189781363] 'agreement among raft nodes before linearized reading' (duration: 265.65442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:40.449047Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"750.502738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:53:40.449313Z","caller":"traceutil/trace.go:172","msg":"trace[70151063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:757; }","duration":"750.768366ms","start":"2026-04-18T17:53:39.698530Z","end":"2026-04-18T17:53:40.449299Z","steps":["trace[70151063] 'agreement among raft nodes before linearized reading' (duration: 750.469967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:40.449359Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:39.698508Z","time spent":"750.840068ms","remote":"127.0.0.1:43486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-18T17:53:40.449407Z","caller":"traceutil/trace.go:172","msg":"trace[654529635] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"721.935391ms","start":"2026-04-18T17:53:39.727461Z","end":"2026-04-18T17:53:40.449396Z","steps":["trace[654529635] 'process raft request' (duration: 721.081395ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:53:40.448708Z","caller":"traceutil/trace.go:172","msg":"trace[1314771532] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"717.136734ms","start":"2026-04-18T17:53:39.731550Z","end":"2026-04-18T17:53:40.448686Z","steps":["trace[1314771532] 'process raft request' (duration: 717.094753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:53:40.449546Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:39.731540Z","time spent":"717.943199ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:53:40.449657Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:53:39.727442Z","time spent":"722.135166ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:54:26.802748Z","caller":"traceutil/trace.go:172","msg":"trace[899826475] linearizableReadLoop","detail":"{readStateIndex:962; appliedIndex:962; }","duration":"102.470812ms","start":"2026-04-18T17:54:26.700257Z","end":"2026-04-18T17:54:26.802728Z","steps":["trace[899826475] 'read index received' (duration: 102.458462ms)","trace[899826475] 'applied index is now lower than readState.Index' (duration: 6.1µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:26.802928Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"102.660287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:26.802945Z","caller":"traceutil/trace.go:172","msg":"trace[1552350789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:916; }","duration":"102.693488ms","start":"2026-04-18T17:54:26.700247Z","end":"2026-04-18T17:54:26.802940Z","steps":["trace[1552350789] 'agreement among raft nodes before linearized reading' (duration: 102.631667ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:26.803062Z","caller":"traceutil/trace.go:172","msg":"trace[376978177] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"105.111543ms","start":"2026-04-18T17:54:26.697930Z","end":"2026-04-18T17:54:26.803041Z","steps":["trace[376978177] 'process raft request' (duration: 104.978438ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:26.820548Z","caller":"traceutil/trace.go:172","msg":"trace[1555114283] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"107.687651ms","start":"2026-04-18T17:54:26.712842Z","end":"2026-04-18T17:54:26.820530Z","steps":["trace[1555114283] 'process raft request' (duration: 107.593418ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:27.044329Z","caller":"traceutil/trace.go:172","msg":"trace[164147723] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"218.95607ms","start":"2026-04-18T17:54:26.825352Z","end":"2026-04-18T17:54:27.044308Z","steps":["trace[164147723] 'process raft request' (duration: 205.514022ms)","trace[164147723] 'compare' (duration: 13.309014ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:54:27.044480Z","caller":"traceutil/trace.go:172","msg":"trace[4205606] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"209.363289ms","start":"2026-04-18T17:54:26.835105Z","end":"2026-04-18T17:54:27.044468Z","steps":["trace[4205606] 'process raft request' (duration: 209.174193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:27.404932Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"207.43918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:27.405095Z","caller":"traceutil/trace.go:172","msg":"trace[533515729] range","detail":"{range_begin:/registry/csistoragecapacities; range_end:; response_count:0; response_revision:920; }","duration":"208.019118ms","start":"2026-04-18T17:54:27.197044Z","end":"2026-04-18T17:54:27.405063Z","steps":["trace[533515729] 'range keys from in-memory index tree' (duration: 206.986986ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:29.405274Z","caller":"traceutil/trace.go:172","msg":"trace[759977681] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"349.360889ms","start":"2026-04-18T17:54:29.055886Z","end":"2026-04-18T17:54:29.405247Z","steps":["trace[759977681] 'process raft request' (duration: 344.014007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:29.405736Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:29.055857Z","time spent":"349.520924ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":478,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:54:36.977738Z","caller":"traceutil/trace.go:172","msg":"trace[658161766] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"102.624227ms","start":"2026-04-18T17:54:36.875084Z","end":"2026-04-18T17:54:36.977708Z","steps":["trace[658161766] 'process raft request' (duration: 102.38496ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:37.076869Z","caller":"traceutil/trace.go:172","msg":"trace[79386258] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"189.505115ms","start":"2026-04-18T17:54:36.887341Z","end":"2026-04-18T17:54:37.076846Z","steps":["trace[79386258] 'process raft request' (duration: 127.992167ms)","trace[79386258] 'compare' (duration: 61.325982ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:37.459086Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"113.566969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:37.459184Z","caller":"traceutil/trace.go:172","msg":"trace[1874061394] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies; range_end:; response_count:0; response_revision:942; }","duration":"113.699943ms","start":"2026-04-18T17:54:37.345467Z","end":"2026-04-18T17:54:37.459167Z","steps":["trace[1874061394] 'range keys from in-memory index tree' (duration: 113.458885ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:39.408475Z","caller":"traceutil/trace.go:172","msg":"trace[1826828086] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"160.853106ms","start":"2026-04-18T17:54:39.247601Z","end":"2026-04-18T17:54:39.408455Z","steps":["trace[1826828086] 'process raft request' (duration: 160.710681ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:40.315119Z","caller":"traceutil/trace.go:172","msg":"trace[1791902748] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"110.496066ms","start":"2026-04-18T17:54:40.204589Z","end":"2026-04-18T17:54:40.315085Z","steps":["trace[1791902748] 'process raft request' (duration: 61.610181ms)","trace[1791902748] 'compare' (duration: 48.704879ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:41.288287Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"127.230764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:41.288356Z","caller":"traceutil/trace.go:172","msg":"trace[1888068752] range","detail":"{range_begin:/registry/csinodes; range_end:; response_count:0; response_revision:949; }","duration":"127.309716ms","start":"2026-04-18T17:54:41.161032Z","end":"2026-04-18T17:54:41.288342Z","steps":["trace[1888068752] 'agreement among raft nodes before linearized reading' (duration: 68.753988ms)","trace[1888068752] 'range keys from in-memory index tree' (duration: 58.447385ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:54:41.288589Z","caller":"traceutil/trace.go:172","msg":"trace[354512672] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"196.357344ms","start":"2026-04-18T17:54:41.092225Z","end":"2026-04-18T17:54:41.288583Z","steps":["trace[354512672] 'process raft request' (duration: 137.606289ms)","trace[354512672] 'compare' (duration: 58.686723ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:54:41.801807Z","caller":"traceutil/trace.go:172","msg":"trace[732259124] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"246.090163ms","start":"2026-04-18T17:54:41.555699Z","end":"2026-04-18T17:54:41.801789Z","steps":["trace[732259124] 'process raft request' (duration: 174.371295ms)","trace[732259124] 'compare' (duration: 71.623486ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:45.646047Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"249.035283ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-18T17:54:45.646648Z","caller":"traceutil/trace.go:172","msg":"trace[251520040] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"119.332634ms","start":"2026-04-18T17:54:45.527299Z","end":"2026-04-18T17:54:45.646632Z","steps":["trace[251520040] 'process raft request' (duration: 119.192519ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:45.646671Z","caller":"traceutil/trace.go:172","msg":"trace[1511397813] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"201.012475ms","start":"2026-04-18T17:54:45.445616Z","end":"2026-04-18T17:54:45.646629Z","steps":["trace[1511397813] 'read index received' (duration: 121.854µs)","trace[1511397813] 'applied index is now lower than readState.Index' (duration: 200.88389ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:45.647415Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"201.269423ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:45.647519Z","caller":"traceutil/trace.go:172","msg":"trace[997672891] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:961; }","duration":"201.935403ms","start":"2026-04-18T17:54:45.445564Z","end":"2026-04-18T17:54:45.647499Z","steps":["trace[997672891] 'agreement among raft nodes before linearized reading' (duration: 201.206881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:47.962593Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"203.000385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:47.962686Z","caller":"traceutil/trace.go:172","msg":"trace[2075330326] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:965; }","duration":"203.107138ms","start":"2026-04-18T17:54:47.759560Z","end":"2026-04-18T17:54:47.962667Z","steps":["trace[2075330326] 'range keys from in-memory index tree' (duration: 202.892461ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:59.606950Z","caller":"traceutil/trace.go:172","msg":"trace[1526428342] linearizableReadLoop","detail":"{readStateIndex:1042; appliedIndex:1042; }","duration":"161.505229ms","start":"2026-04-18T17:54:59.445410Z","end":"2026-04-18T17:54:59.606916Z","steps":["trace[1526428342] 'read index received' (duration: 161.496578ms)","trace[1526428342] 'applied index is now lower than readState.Index' (duration: 7.221µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:59.710279Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"264.829027ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:59.710438Z","caller":"traceutil/trace.go:172","msg":"trace[1846909966] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:990; }","duration":"264.959582ms","start":"2026-04-18T17:54:59.445403Z","end":"2026-04-18T17:54:59.710363Z","steps":["trace[1846909966] 'agreement among raft nodes before linearized reading' (duration: 161.640233ms)","trace[1846909966] 'range keys from in-memory index tree' (duration: 103.159434ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:59.710564Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"103.395241ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:54:59.711239Z","caller":"traceutil/trace.go:172","msg":"trace[1793707158] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"288.132807ms","start":"2026-04-18T17:54:59.423084Z","end":"2026-04-18T17:54:59.711217Z","steps":["trace[1793707158] 'process raft request' (duration: 184.016692ms)","trace[1793707158] 'compare' (duration: 103.237136ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:02.457011Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125954130104812743,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T17:55:02.529550Z","caller":"traceutil/trace.go:172","msg":"trace[848497745] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1049; }","duration":"573.313806ms","start":"2026-04-18T17:55:01.956171Z","end":"2026-04-18T17:55:02.529485Z","steps":["trace[848497745] 'read index received' (duration: 573.300875ms)","trace[848497745] 'applied index is now lower than readState.Index' (duration: 10.78µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:02.530042Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"573.483092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:02.530195Z","caller":"traceutil/trace.go:172","msg":"trace[857194569] range","detail":"{range_begin:/registry/namespaces; range_end:; response_count:0; response_revision:996; }","duration":"574.010729ms","start":"2026-04-18T17:55:01.956155Z","end":"2026-04-18T17:55:02.530165Z","steps":["trace[857194569] 'agreement among raft nodes before linearized reading' (duration: 573.42289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:02.530282Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:01.956135Z","time spent":"574.117592ms","remote":"127.0.0.1:43718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces\" limit:1 "} {"level":"info","ts":"2026-04-18T17:55:02.530618Z","caller":"traceutil/trace.go:172","msg":"trace[2890833] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"602.100504ms","start":"2026-04-18T17:55:01.928488Z","end":"2026-04-18T17:55:02.530588Z","steps":["trace[2890833] 'process raft request' (duration: 601.08123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:02.530806Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:01.928446Z","time spent":"602.229439ms","remote":"127.0.0.1:43980","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-04-18T17:55:02.531176Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"238.370952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-18T17:55:02.531647Z","caller":"traceutil/trace.go:172","msg":"trace[687389743] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:997; }","duration":"238.862398ms","start":"2026-04-18T17:55:02.292758Z","end":"2026-04-18T17:55:02.531621Z","steps":["trace[687389743] 'agreement among raft nodes before linearized reading' (duration: 237.300256ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:42.945484Z","caller":"traceutil/trace.go:172","msg":"trace[589837704] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1149; }","duration":"116.483005ms","start":"2026-04-18T17:55:42.828973Z","end":"2026-04-18T17:55:42.945456Z","steps":["trace[589837704] 'read index received' (duration: 116.475115ms)","trace[589837704] 'applied index is now lower than readState.Index' (duration: 6.78µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:42.945829Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.837867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-18T17:55:42.945858Z","caller":"traceutil/trace.go:172","msg":"trace[1636498014] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:1088; }","duration":"116.892179ms","start":"2026-04-18T17:55:42.828958Z","end":"2026-04-18T17:55:42.945851Z","steps":["trace[1636498014] 'agreement among raft nodes before linearized reading' (duration: 116.638271ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:42.946149Z","caller":"traceutil/trace.go:172","msg":"trace[131270188] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"167.886058ms","start":"2026-04-18T17:55:42.778225Z","end":"2026-04-18T17:55:42.946111Z","steps":["trace[131270188] 'process raft request' (duration: 167.596248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:42.946233Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"115.016008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-04-18T17:55:42.946337Z","caller":"traceutil/trace.go:172","msg":"trace[1843816876] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1089; }","duration":"115.145152ms","start":"2026-04-18T17:55:42.831171Z","end":"2026-04-18T17:55:42.946316Z","steps":["trace[1843816876] 'agreement among raft nodes before linearized reading' (duration: 114.875343ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:43.109587Z","caller":"traceutil/trace.go:172","msg":"trace[1982572774] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"142.666241ms","start":"2026-04-18T17:55:42.966898Z","end":"2026-04-18T17:55:43.109564Z","steps":["trace[1982572774] 'process raft request' (duration: 142.404282ms)"],"step_count":1}