{"level":"warn","ts":"2026-04-17T00:54:31.231426Z","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-17T00:54:31.231584Z","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-17T00:54:31.231597Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.204.45.72:2380","--initial-cluster=controller=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72:2380","--name=controller","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-04-17T00:54:31.231679Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-04-17T00:54:31.231704Z","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-17T00:54:31.231714Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-04-17T00:54:31.231743Z","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-17T00:54:31.232308Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-04-17T00:54:31.232422Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.204.45.72:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"feature-gates":"InitialCorruptCheck=true","initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","discovery-token":"","discovery-endpoints":"","discovery-dial-timeout":"2s","discovery-request-timeout":"5s","discovery-keepalive-time":"2s","discovery-keepalive-timeout":"6s","discovery-insecure-transport":true,"discovery-insecure-skip-tls-verify":false,"discovery-cert":"","discovery-key":"","discovery-cacert":"","discovery-user":"","downgrade-check-interval":"5s","max-learners":1,"v2-deprecation":"write-only"} {"level":"info","ts":"2026-04-17T00:54:31.251051Z","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: 0xc00049e3a0}"} {"level":"info","ts":"2026-04-17T00:54:31.261055Z","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-17T00:54:31.261103Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.166346ms"} {"level":"info","ts":"2026-04-17T00:54:31.261129Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-04-17T00:54:31.261142Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-04-17T00:54:31.261183Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-04-17T00:54:31.273311Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-04-17T00:54:31.273397Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-04-17T00:54:31.273424Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-04-17T00:54:31.273514Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T00:54:31.273561Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-04-17T00:54:31.273575Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T00:54:31.273594Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-04-17T00:54:31.273634Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-04-17T00:54:31.290004Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T00:54:31.294842Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T00:54:31.321700Z","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-17T00:54:31.322413Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T00:54:31.322679Z","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-17T00:54:31.326725Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-04-17T00:54:31.326937Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-04-17T00:54:31.327025Z","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-17T00:54:31.327075Z","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-17T00:54:31.327098Z","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-17T00:54:31.327502Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-04-17T00:54:31.327538Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-04-17T00:54:31.322667Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T00:54:31.328181Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T00:54:31.328258Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T00:54:31.974163Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T00:54:31.974403Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T00:54:31.974796Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-04-17T00:54:31.974934Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"50e03cebfd94cbba has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-17T00:54:31.975054Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-04-17T00:54:31.977147Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-04-17T00:54:31.977229Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"50e03cebfd94cbba has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-17T00:54:31.977338Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-04-17T00:54:31.977355Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-04-17T00:54:31.979892Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-04-17T00:54:31.982248Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:54:31.982260Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:54:31.982241Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:controller ClientURLs:[https://199.204.45.72:2379]}","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T00:54:31.983450Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-17T00:54:31.983799Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T00:54:31.983890Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-04-17T00:54:31.984380Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-04-17T00:54:31.984429Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.6"} {"level":"info","ts":"2026-04-17T00:54:31.986618Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-04-17T00:54:31.986724Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-17T00:54:31.986811Z","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-17T00:54:31.986964Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-04-17T00:54:31.986968Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-04-17T00:54:31.988455Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-17T00:54:32.001267Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59208","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.002698Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59238","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-17T00:54:32.004909Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"warn","ts":"2026-04-17T00:54:32.016832Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59256","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.025320Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59272","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.048285Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59308","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.066123Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59344","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.074349Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59368","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.084277Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59370","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.094816Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59386","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.102046Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59396","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.120972Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59426","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.128944Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59456","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.139193Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59478","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.149261Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59482","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.158761Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59494","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.168963Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59512","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.177437Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59528","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.194120Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59540","server-name":"","error":"read tcp 127.0.0.1:2379->127.0.0.1:59540: read: connection reset by peer"} {"level":"warn","ts":"2026-04-17T00:54:32.199841Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59546","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.207438Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59560","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.217704Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59568","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.254440Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59604","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.263741Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59620","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.273336Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59638","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.282857Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59648","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.290847Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59672","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.299193Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59680","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.307436Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59710","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.317404Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59728","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.324812Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59760","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.336030Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59770","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.342553Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59784","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.351470Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59812","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.360617Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59834","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.376297Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59850","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.386248Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59868","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.397344Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59880","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.431887Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59904","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.452511Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59924","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.461630Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59948","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.468511Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59958","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.476351Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59970","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.499309Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60008","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.534326Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60022","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.556466Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60040","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.573959Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60090","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.583858Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60096","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.593591Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60126","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.603826Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60142","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.611255Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60162","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.621614Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60176","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.629937Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60204","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.673940Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60224","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.684668Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60250","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.693653Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60264","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:54:32.752822Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60284","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-17T00:54:34.312247Z","caller":"traceutil/trace.go:172","msg":"trace[1954189344] linearizableReadLoop","detail":"{readStateIndex:72; appliedIndex:72; }","duration":"122.961642ms","start":"2026-04-17T00:54:34.189256Z","end":"2026-04-17T00:54:34.312217Z","steps":["trace[1954189344] 'read index received' (duration: 122.957432ms)","trace[1954189344] 'applied index is now lower than readState.Index' (duration: 3.34µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:34.524414Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"335.089901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-17T00:54:34.524492Z","caller":"traceutil/trace.go:172","msg":"trace[1894619395] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:0; response_revision:68; }","duration":"335.218536ms","start":"2026-04-17T00:54:34.189252Z","end":"2026-04-17T00:54:34.524470Z","steps":["trace[1894619395] 'agreement among raft nodes before linearized reading' (duration: 123.071647ms)","trace[1894619395] 'range keys from in-memory index tree' (duration: 211.965622ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:34.524533Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:34.189239Z","time spent":"335.284589ms","remote":"127.0.0.1:59892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/view\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:54:34.525176Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"212.227163ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-17T00:54:34.525653Z","caller":"traceutil/trace.go:172","msg":"trace[1723784760] transaction","detail":"{read_only:false; response_revision:69; number_of_response:1; }","duration":"336.482261ms","start":"2026-04-17T00:54:34.189148Z","end":"2026-04-17T00:54:34.525630Z","steps":["trace[1723784760] 'process raft request' (duration: 123.058006ms)","trace[1723784760] 'compare' (duration: 212.105898ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:34.525772Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:34.189132Z","time spent":"336.565495ms","remote":"127.0.0.1:59898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:34.525861Z","caller":"traceutil/trace.go:172","msg":"trace[1024825721] linearizableReadLoop","detail":"{readStateIndex:73; appliedIndex:72; }","duration":"213.448396ms","start":"2026-04-17T00:54:34.312324Z","end":"2026-04-17T00:54:34.525773Z","steps":["trace[1024825721] 'read index received' (duration: 30.441µs)","trace[1024825721] 'applied index is now lower than readState.Index' (duration: 213.415905ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:34.526016Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"274.825833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-17T00:54:34.526136Z","caller":"traceutil/trace.go:172","msg":"trace[1410486997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:69; }","duration":"274.98775ms","start":"2026-04-17T00:54:34.251128Z","end":"2026-04-17T00:54:34.526116Z","steps":["trace[1410486997] 'agreement among raft nodes before linearized reading' (duration: 274.76562ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:35.002942Z","caller":"traceutil/trace.go:172","msg":"trace[620565548] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"427.473409ms","start":"2026-04-17T00:54:34.575442Z","end":"2026-04-17T00:54:35.002915Z","steps":["trace[620565548] 'process raft request' (duration: 403.105857ms)","trace[620565548] 'compare' (duration: 24.246127ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:35.003082Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:34.575403Z","time spent":"427.622726ms","remote":"127.0.0.1:59892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":634,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:35.005462Z","caller":"traceutil/trace.go:172","msg":"trace[1876605722] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"429.272859ms","start":"2026-04-17T00:54:34.576150Z","end":"2026-04-17T00:54:35.005422Z","steps":["trace[1876605722] 'process raft request' (duration: 429.0873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:35.005754Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:34.576132Z","time spent":"429.495308ms","remote":"127.0.0.1:59358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":652,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:54:35.539344Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219215532288493,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T00:54:35.564208Z","caller":"traceutil/trace.go:172","msg":"trace[1509254307] linearizableReadLoop","detail":"{readStateIndex:83; appliedIndex:83; }","duration":"525.188217ms","start":"2026-04-17T00:54:35.038982Z","end":"2026-04-17T00:54:35.564170Z","steps":["trace[1509254307] 'read index received' (duration: 525.177267ms)","trace[1509254307] 'applied index is now lower than readState.Index' (duration: 8.88µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:36.065062Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219215532288498,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:54:36.161950Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.122943775s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/controller.18a6fecf2af6a3ab\" limit:1 ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-17T00:54:36.162042Z","caller":"traceutil/trace.go:172","msg":"trace[493401231] range","detail":"{range_begin:/registry/events/default/controller.18a6fecf2af6a3ab; range_end:; response_count:1; response_revision:78; }","duration":"1.123046359s","start":"2026-04-17T00:54:35.038973Z","end":"2026-04-17T00:54:36.162019Z","steps":["trace[493401231] 'agreement among raft nodes before linearized reading' (duration: 525.357565ms)","trace[493401231] 'range keys from in-memory index tree' (duration: 597.474605ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:36.162117Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:35.038939Z","time spent":"1.123131963s","remote":"127.0.0.1:59358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":686,"request content":"key:\"/registry/events/default/controller.18a6fecf2af6a3ab\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:54:36.162317Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"597.949696ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-17T00:54:36.162446Z","caller":"traceutil/trace.go:172","msg":"trace[516618024] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"1.131307861s","start":"2026-04-17T00:54:35.031116Z","end":"2026-04-17T00:54:36.162424Z","steps":["trace[516618024] 'process raft request' (duration: 533.176667ms)","trace[516618024] 'compare' (duration: 597.214633ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:36.162513Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:35.031100Z","time spent":"1.131392895s","remote":"127.0.0.1:59892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":665,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:36.215603Z","caller":"traceutil/trace.go:172","msg":"trace[1003747034] linearizableReadLoop","detail":"{readStateIndex:84; appliedIndex:84; }","duration":"651.283833ms","start":"2026-04-17T00:54:35.564293Z","end":"2026-04-17T00:54:36.215577Z","steps":["trace[1003747034] 'read index received' (duration: 651.274722ms)","trace[1003747034] 'applied index is now lower than readState.Index' (duration: 8.311µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:36.215766Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"962.927946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-17T00:54:36.215791Z","caller":"traceutil/trace.go:172","msg":"trace[1624478430] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:79; }","duration":"962.977058ms","start":"2026-04-17T00:54:35.252808Z","end":"2026-04-17T00:54:36.215785Z","steps":["trace[1624478430] 'agreement among raft nodes before linearized reading' (duration: 962.883534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:36.215821Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:35.252785Z","time spent":"963.03245ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T00:54:36.215973Z","caller":"traceutil/trace.go:172","msg":"trace[857083533] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"1.098323366s","start":"2026-04-17T00:54:35.117631Z","end":"2026-04-17T00:54:36.215954Z","steps":["trace[857083533] 'process raft request' (duration: 1.098246713s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:36.216108Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:35.117595Z","time spent":"1.098453372s","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4321,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:36.216112Z","caller":"traceutil/trace.go:172","msg":"trace[443003796] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"1.172723675s","start":"2026-04-17T00:54:35.043292Z","end":"2026-04-17T00:54:36.216016Z","steps":["trace[443003796] 'process raft request' (duration: 1.172453463s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:36.216251Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:35.043264Z","time spent":"1.172914754s","remote":"127.0.0.1:59650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":976,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:54:36.277258Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"111.984838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:public-info-viewer\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-17T00:54:36.277328Z","caller":"traceutil/trace.go:172","msg":"trace[1761903536] range","detail":"{range_begin:/registry/clusterroles/system:public-info-viewer; range_end:; response_count:0; response_revision:81; }","duration":"112.064871ms","start":"2026-04-17T00:54:36.165248Z","end":"2026-04-17T00:54:36.277313Z","steps":["trace[1761903536] 'agreement among raft nodes before linearized reading' (duration: 99.76253ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:36.277623Z","caller":"traceutil/trace.go:172","msg":"trace[1103230532] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"112.004789ms","start":"2026-04-17T00:54:36.165590Z","end":"2026-04-17T00:54:36.277595Z","steps":["trace[1103230532] 'process raft request' (duration: 99.424215ms)","trace[1103230532] 'compare' (duration: 12.393106ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:36.685501Z","caller":"traceutil/trace.go:172","msg":"trace[1625920761] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"148.288345ms","start":"2026-04-17T00:54:36.537182Z","end":"2026-04-17T00:54:36.685470Z","steps":["trace[1625920761] 'process raft request' (duration: 148.237912ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:36.685877Z","caller":"traceutil/trace.go:172","msg":"trace[253692526] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"148.982057ms","start":"2026-04-17T00:54:36.536880Z","end":"2026-04-17T00:54:36.685862Z","steps":["trace[253692526] 'process raft request' (duration: 133.500265ms)","trace[253692526] 'compare' (duration: 14.907826ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:37.541012Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"100.323144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pv-protection-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:54:37.541639Z","caller":"traceutil/trace.go:172","msg":"trace[1992810070] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"114.850245ms","start":"2026-04-17T00:54:37.426758Z","end":"2026-04-17T00:54:37.541608Z","steps":["trace[1992810070] 'process raft request' (duration: 27.928124ms)","trace[1992810070] 'compare' (duration: 86.512543ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:37.541695Z","caller":"traceutil/trace.go:172","msg":"trace[750518347] range","detail":"{range_begin:/registry/clusterroles/system:controller:pv-protection-controller; range_end:; response_count:0; response_revision:174; }","duration":"101.019805ms","start":"2026-04-17T00:54:37.440648Z","end":"2026-04-17T00:54:37.541668Z","steps":["trace[750518347] 'range keys from in-memory index tree' (duration: 86.310674ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:38.030822Z","caller":"traceutil/trace.go:172","msg":"trace[1098645814] transaction","detail":"{read_only:false; response_revision:184; number_of_response:1; }","duration":"151.465919ms","start":"2026-04-17T00:54:37.879338Z","end":"2026-04-17T00:54:38.030804Z","steps":["trace[1098645814] 'process raft request' (duration: 140.64637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:38.345042Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"172.280816ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:54:38.345215Z","caller":"traceutil/trace.go:172","msg":"trace[1508965546] transaction","detail":"{read_only:false; response_revision:187; number_of_response:1; }","duration":"215.854069ms","start":"2026-04-17T00:54:38.129329Z","end":"2026-04-17T00:54:38.345183Z","steps":["trace[1508965546] 'process raft request' (duration: 43.360014ms)","trace[1508965546] 'compare' (duration: 172.120439ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:38.488147Z","caller":"traceutil/trace.go:172","msg":"trace[2031829370] transaction","detail":"{read_only:false; response_revision:188; number_of_response:1; }","duration":"137.543593ms","start":"2026-04-17T00:54:38.350574Z","end":"2026-04-17T00:54:38.488117Z","steps":["trace[2031829370] 'process raft request' (duration: 123.839835ms)","trace[2031829370] 'compare' (duration: 13.322542ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:38.693052Z","caller":"traceutil/trace.go:172","msg":"trace[1771713581] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"113.818881ms","start":"2026-04-17T00:54:38.579187Z","end":"2026-04-17T00:54:38.693006Z","steps":["trace[1771713581] 'process raft request' (duration: 34.090242ms)","trace[1771713581] 'compare' (duration: 79.512049ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:38.834138Z","caller":"traceutil/trace.go:172","msg":"trace[512810469] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"133.753337ms","start":"2026-04-17T00:54:38.700306Z","end":"2026-04-17T00:54:38.834059Z","steps":["trace[512810469] 'process raft request' (duration: 133.689474ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:38.834284Z","caller":"traceutil/trace.go:172","msg":"trace[195078983] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"136.815572ms","start":"2026-04-17T00:54:38.697425Z","end":"2026-04-17T00:54:38.834241Z","steps":["trace[195078983] 'process raft request' (duration: 96.898721ms)","trace[195078983] 'compare' (duration: 39.479412ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:39.076943Z","caller":"traceutil/trace.go:172","msg":"trace[1069493543] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"197.09918ms","start":"2026-04-17T00:54:38.879819Z","end":"2026-04-17T00:54:39.076918Z","steps":["trace[1069493543] 'process raft request' (duration: 110.704293ms)","trace[1069493543] 'compare' (duration: 86.23083ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:39.086577Z","caller":"traceutil/trace.go:172","msg":"trace[1294284170] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"192.969498ms","start":"2026-04-17T00:54:38.893587Z","end":"2026-04-17T00:54:39.086556Z","steps":["trace[1294284170] 'process raft request' (duration: 192.833613ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:39.302848Z","caller":"traceutil/trace.go:172","msg":"trace[1400866534] linearizableReadLoop","detail":"{readStateIndex:211; appliedIndex:211; }","duration":"178.964545ms","start":"2026-04-17T00:54:39.123861Z","end":"2026-04-17T00:54:39.302826Z","steps":["trace[1400866534] 'read index received' (duration: 178.951544ms)","trace[1400866534] 'applied index is now lower than readState.Index' (duration: 12.381µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:39.422825Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"298.92433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:ephemeral-volume-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:54:39.422921Z","caller":"traceutil/trace.go:172","msg":"trace[1920195706] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:ephemeral-volume-controller; range_end:; response_count:0; response_revision:206; }","duration":"299.038666ms","start":"2026-04-17T00:54:39.123858Z","end":"2026-04-17T00:54:39.422896Z","steps":["trace[1920195706] 'agreement among raft nodes before linearized reading' (duration: 179.07718ms)","trace[1920195706] 'range keys from in-memory index tree' (duration: 119.811178ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:39.423246Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"120.220697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:54:39.423355Z","caller":"traceutil/trace.go:172","msg":"trace[1343252727] linearizableReadLoop","detail":"{readStateIndex:212; appliedIndex:211; }","duration":"120.430107ms","start":"2026-04-17T00:54:39.302909Z","end":"2026-04-17T00:54:39.423339Z","steps":["trace[1343252727] 'read index received' (duration: 38.982µs)","trace[1343252727] 'applied index is now lower than readState.Index' (duration: 120.390045ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:39.423423Z","caller":"traceutil/trace.go:172","msg":"trace[1803433648] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"311.611956ms","start":"2026-04-17T00:54:39.111784Z","end":"2026-04-17T00:54:39.423396Z","steps":["trace[1803433648] 'process raft request' (duration: 191.004431ms)","trace[1803433648] 'compare' (duration: 120.072971ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:39.423489Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"171.530694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:54:39.423527Z","caller":"traceutil/trace.go:172","msg":"trace[721928606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:207; }","duration":"171.568396ms","start":"2026-04-17T00:54:39.251949Z","end":"2026-04-17T00:54:39.423517Z","steps":["trace[721928606] 'agreement among raft nodes before linearized reading' (duration: 171.43555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:39.423723Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:39.111762Z","time spent":"311.758562ms","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6001,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:54:39.973757Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"510.675605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:generic-garbage-collector\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T00:54:39.973811Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"422.061306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:54:39.973949Z","caller":"traceutil/trace.go:172","msg":"trace[574938860] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:generic-garbage-collector; range_end:; response_count:0; response_revision:209; }","duration":"510.938067ms","start":"2026-04-17T00:54:39.462990Z","end":"2026-04-17T00:54:39.973928Z","steps":["trace[574938860] 'agreement among raft nodes before linearized reading' (duration: 88.627858ms)","trace[574938860] 'range keys from in-memory index tree' (duration: 422.009114ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:39.974157Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:39.462945Z","time spent":"511.198968ms","remote":"127.0.0.1:59896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/system:controller:generic-garbage-collector\" limit:1 "} {"level":"info","ts":"2026-04-17T00:54:39.974159Z","caller":"traceutil/trace.go:172","msg":"trace[1489064082] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"530.456107ms","start":"2026-04-17T00:54:39.443675Z","end":"2026-04-17T00:54:39.974132Z","steps":["trace[1489064082] 'process raft request' (duration: 108.001243ms)","trace[1489064082] 'compare' (duration: 421.932731ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:39.974304Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:39.443659Z","time spent":"530.571192ms","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7975,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:54:39.974351Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"447.325512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:54:39.974057Z","caller":"traceutil/trace.go:172","msg":"trace[333040665] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:214; }","duration":"422.530388ms","start":"2026-04-17T00:54:39.551515Z","end":"2026-04-17T00:54:39.974045Z","steps":["trace[333040665] 'read index received' (duration: 90.374µs)","trace[333040665] 'applied index is now lower than readState.Index' (duration: 422.438994ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:39.974474Z","caller":"traceutil/trace.go:172","msg":"trace[673770572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:210; }","duration":"447.416396ms","start":"2026-04-17T00:54:39.527008Z","end":"2026-04-17T00:54:39.974424Z","steps":["trace[673770572] 'agreement among raft nodes before linearized reading' (duration: 447.209417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:39.974644Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:39.526992Z","time spent":"447.517881ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T00:54:40.088981Z","caller":"traceutil/trace.go:172","msg":"trace[1844301201] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:215; }","duration":"109.525906ms","start":"2026-04-17T00:54:39.979435Z","end":"2026-04-17T00:54:40.088961Z","steps":["trace[1844301201] 'read index received' (duration: 109.521026ms)","trace[1844301201] 'applied index is now lower than readState.Index' (duration: 4.05µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:40.375603Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"396.168448ms","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-17T00:54:40.375691Z","caller":"traceutil/trace.go:172","msg":"trace[281549614] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-controller; range_end:; response_count:1; response_revision:210; }","duration":"396.262703ms","start":"2026-04-17T00:54:39.979405Z","end":"2026-04-17T00:54:40.375667Z","steps":["trace[281549614] 'agreement among raft nodes before linearized reading' (duration: 109.652981ms)","trace[281549614] 'range keys from in-memory index tree' (duration: 286.395421ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:40.375688Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"286.613551ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-04-17T00:54:40.375730Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:39.979388Z","time spent":"396.331776ms","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":3345,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 "} {"level":"info","ts":"2026-04-17T00:54:40.375758Z","caller":"traceutil/trace.go:172","msg":"trace[2112845339] linearizableReadLoop","detail":"{readStateIndex:216; appliedIndex:215; }","duration":"286.707586ms","start":"2026-04-17T00:54:40.089037Z","end":"2026-04-17T00:54:40.375745Z","steps":["trace[2112845339] 'read index received' (duration: 33.802µs)","trace[2112845339] 'applied index is now lower than readState.Index' (duration: 286.672744ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:40.375956Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"320.542639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:54:40.376049Z","caller":"traceutil/trace.go:172","msg":"trace[1790679446] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:211; }","duration":"320.657784ms","start":"2026-04-17T00:54:40.055371Z","end":"2026-04-17T00:54:40.376029Z","steps":["trace[1790679446] 'agreement among raft nodes before linearized reading' (duration: 320.461146ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:40.376159Z","caller":"traceutil/trace.go:172","msg":"trace[40530347] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"398.405408ms","start":"2026-04-17T00:54:39.977741Z","end":"2026-04-17T00:54:40.376146Z","steps":["trace[40530347] 'process raft request' (duration: 111.268753ms)","trace[40530347] 'compare' (duration: 286.430134ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:40.376214Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:39.977714Z","time spent":"398.47433ms","remote":"127.0.0.1:59896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":760,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:54:40.376319Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:40.055353Z","time spent":"320.807461ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"info","ts":"2026-04-17T00:54:40.746017Z","caller":"traceutil/trace.go:172","msg":"trace[1997538641] linearizableReadLoop","detail":"{readStateIndex:216; appliedIndex:216; }","duration":"193.585181ms","start":"2026-04-17T00:54:40.552408Z","end":"2026-04-17T00:54:40.745993Z","steps":["trace[1997538641] 'read index received' (duration: 193.57672ms)","trace[1997538641] 'applied index is now lower than readState.Index' (duration: 7.26µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:40.833440Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"281.027221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:54:40.834251Z","caller":"traceutil/trace.go:172","msg":"trace[228124460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:211; }","duration":"281.822397ms","start":"2026-04-17T00:54:40.552393Z","end":"2026-04-17T00:54:40.834215Z","steps":["trace[228124460] 'agreement among raft nodes before linearized reading' (duration: 193.676284ms)","trace[228124460] 'range keys from in-memory index tree' (duration: 87.302915ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:40.833711Z","caller":"traceutil/trace.go:172","msg":"trace[953914856] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"452.613286ms","start":"2026-04-17T00:54:40.381044Z","end":"2026-04-17T00:54:40.833658Z","steps":["trace[953914856] 'process raft request' (duration: 365.093892ms)","trace[953914856] 'compare' (duration: 87.050964ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:40.834545Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:40.381028Z","time spent":"453.423383ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:40.899663Z","caller":"traceutil/trace.go:172","msg":"trace[798469432] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"517.231957ms","start":"2026-04-17T00:54:40.382403Z","end":"2026-04-17T00:54:40.899635Z","steps":["trace[798469432] 'process raft request' (duration: 517.023218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:40.899803Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:40.382389Z","time spent":"517.354573ms","remote":"127.0.0.1:59896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":760,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:40.899678Z","caller":"traceutil/trace.go:172","msg":"trace[965564160] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"513.51643ms","start":"2026-04-17T00:54:40.386146Z","end":"2026-04-17T00:54:40.899662Z","steps":["trace[965564160] 'process raft request' (duration: 513.444307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:40.900067Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:40.386133Z","time spent":"513.772232ms","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4986,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:54:41.791983Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"889.119267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:job-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:54:41.792115Z","caller":"traceutil/trace.go:172","msg":"trace[1755575931] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:job-controller; range_end:; response_count:0; response_revision:214; }","duration":"889.285405ms","start":"2026-04-17T00:54:40.902799Z","end":"2026-04-17T00:54:41.792085Z","steps":["trace[1755575931] 'agreement among raft nodes before linearized reading' (duration: 48.446466ms)","trace[1755575931] 'range keys from in-memory index tree' (duration: 840.601186ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:41.792098Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"840.65244ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-04-17T00:54:41.792191Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:40.902784Z","time spent":"889.380169ms","remote":"127.0.0.1:59896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/system:controller:job-controller\" limit:1 "} {"level":"info","ts":"2026-04-17T00:54:41.792291Z","caller":"traceutil/trace.go:172","msg":"trace[1956806496] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"950.126337ms","start":"2026-04-17T00:54:40.842147Z","end":"2026-04-17T00:54:41.792274Z","steps":["trace[1956806496] 'process raft request' (duration: 950.052314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:41.792409Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:40.842114Z","time spent":"950.228581ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:54:41.792457Z","caller":"traceutil/trace.go:172","msg":"trace[2070360897] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"951.423815ms","start":"2026-04-17T00:54:40.840918Z","end":"2026-04-17T00:54:41.792342Z","steps":["trace[2070360897] 'process raft request' (duration: 110.459621ms)","trace[2070360897] 'compare' (duration: 840.416049ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:41.792676Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:40.840890Z","time spent":"951.680906ms","remote":"127.0.0.1:59358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":755,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:41.808592Z","caller":"traceutil/trace.go:172","msg":"trace[951728727] linearizableReadLoop","detail":"{readStateIndex:221; appliedIndex:221; }","duration":"456.574821ms","start":"2026-04-17T00:54:41.351991Z","end":"2026-04-17T00:54:41.808566Z","steps":["trace[951728727] 'read index received' (duration: 456.568491ms)","trace[951728727] 'applied index is now lower than readState.Index' (duration: 5.2µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:41.808719Z","caller":"traceutil/trace.go:172","msg":"trace[20460551] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"583.526053ms","start":"2026-04-17T00:54:41.225183Z","end":"2026-04-17T00:54:41.808709Z","steps":["trace[20460551] 'process raft request' (duration: 583.419328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:41.808781Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:41.225143Z","time spent":"583.608346ms","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5675,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:54:41.808838Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"456.73543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:54:41.809001Z","caller":"traceutil/trace.go:172","msg":"trace[733355564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:217; }","duration":"456.919558ms","start":"2026-04-17T00:54:41.351985Z","end":"2026-04-17T00:54:41.808904Z","steps":["trace[733355564] 'agreement among raft nodes before linearized reading' (duration: 456.685687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:41.809063Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:41.351954Z","time spent":"457.094695ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T00:54:41.991205Z","caller":"traceutil/trace.go:172","msg":"trace[2122330961] transaction","detail":"{read_only:false; response_revision:220; number_of_response:1; }","duration":"166.514368ms","start":"2026-04-17T00:54:41.824667Z","end":"2026-04-17T00:54:41.991181Z","steps":["trace[2122330961] 'process raft request' (duration: 117.624712ms)","trace[2122330961] 'compare' (duration: 48.746469ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:42.326829Z","caller":"traceutil/trace.go:172","msg":"trace[679786967] linearizableReadLoop","detail":"{readStateIndex:226; appliedIndex:226; }","duration":"297.607282ms","start":"2026-04-17T00:54:42.029169Z","end":"2026-04-17T00:54:42.326776Z","steps":["trace[679786967] 'read index received' (duration: 297.589792ms)","trace[679786967] 'applied index is now lower than readState.Index' (duration: 14.88µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:42.446306Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"417.115467ms","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-17T00:54:42.446418Z","caller":"traceutil/trace.go:172","msg":"trace[47678387] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-controller; range_end:; response_count:1; response_revision:220; }","duration":"417.241394ms","start":"2026-04-17T00:54:42.029152Z","end":"2026-04-17T00:54:42.446393Z","steps":["trace[47678387] 'agreement among raft nodes before linearized reading' (duration: 297.848803ms)","trace[47678387] 'range keys from in-memory index tree' (duration: 118.875438ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:42.446314Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"119.108468ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-17T00:54:42.446471Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:42.029124Z","time spent":"417.334178ms","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":5712,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-controller\" limit:1 "} {"level":"info","ts":"2026-04-17T00:54:42.447159Z","caller":"traceutil/trace.go:172","msg":"trace[1798643963] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"446.406386ms","start":"2026-04-17T00:54:42.000590Z","end":"2026-04-17T00:54:42.446997Z","steps":["trace[1798643963] 'process raft request' (duration: 326.484022ms)","trace[1798643963] 'compare' (duration: 118.895558ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:42.447184Z","caller":"traceutil/trace.go:172","msg":"trace[340585700] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"415.243773ms","start":"2026-04-17T00:54:42.031798Z","end":"2026-04-17T00:54:42.447042Z","steps":["trace[340585700] 'process raft request' (duration: 414.777042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:42.447443Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:42.000573Z","time spent":"446.650548ms","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7563,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:54:42.447574Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:42.031740Z","time spent":"415.743486ms","remote":"127.0.0.1:59896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":756,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:42.755507Z","caller":"traceutil/trace.go:172","msg":"trace[204307356] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"124.981643ms","start":"2026-04-17T00:54:42.630375Z","end":"2026-04-17T00:54:42.755357Z","steps":["trace[204307356] 'process raft request' (duration: 60.617162ms)","trace[204307356] 'compare' (duration: 63.739102ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:43.554770Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"129.090389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-17T00:54:43.554950Z","caller":"traceutil/trace.go:172","msg":"trace[838800173] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:260; }","duration":"129.295158ms","start":"2026-04-17T00:54:43.425624Z","end":"2026-04-17T00:54:43.554919Z","steps":["trace[838800173] 'range keys from in-memory index tree' (duration: 128.975823ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:43.556652Z","caller":"traceutil/trace.go:172","msg":"trace[1501000019] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"127.091858ms","start":"2026-04-17T00:54:43.429511Z","end":"2026-04-17T00:54:43.556603Z","steps":["trace[1501000019] 'process raft request' (duration: 126.842387ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:45.035722Z","caller":"traceutil/trace.go:172","msg":"trace[544787454] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"117.743707ms","start":"2026-04-17T00:54:44.917959Z","end":"2026-04-17T00:54:45.035703Z","steps":["trace[544787454] 'process raft request' (duration: 34.15223ms)","trace[544787454] 'compare' (duration: 83.474891ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:45.439338Z","caller":"traceutil/trace.go:172","msg":"trace[1823523086] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"383.885353ms","start":"2026-04-17T00:54:45.055415Z","end":"2026-04-17T00:54:45.439301Z","steps":["trace[1823523086] 'process raft request' (duration: 320.133302ms)","trace[1823523086] 'compare' (duration: 63.537361ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:45.439501Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:45.055327Z","time spent":"384.095443ms","remote":"127.0.0.1:59532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3846,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:54:45.439569Z","caller":"traceutil/trace.go:172","msg":"trace[604518418] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"371.774503ms","start":"2026-04-17T00:54:45.067765Z","end":"2026-04-17T00:54:45.439539Z","steps":["trace[604518418] 'process raft request' (duration: 371.437296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:45.439880Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:45.067699Z","time spent":"372.118618ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:45.439951Z","caller":"traceutil/trace.go:172","msg":"trace[803179866] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"305.38677ms","start":"2026-04-17T00:54:45.134492Z","end":"2026-04-17T00:54:45.439878Z","steps":["trace[803179866] 'process raft request' (duration: 304.995192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:45.440249Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:45.134465Z","time spent":"305.667052ms","remote":"127.0.0.1:59852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":302,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:46.614373Z","caller":"traceutil/trace.go:172","msg":"trace[83062103] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"145.340898ms","start":"2026-04-17T00:54:46.469005Z","end":"2026-04-17T00:54:46.614346Z","steps":["trace[83062103] 'process raft request' (duration: 124.301487ms)","trace[83062103] 'compare' (duration: 20.926016ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:47.552721Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"834.293665ms","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-17T00:54:47.552822Z","caller":"traceutil/trace.go:172","msg":"trace[1800569275] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:342; }","duration":"834.421301ms","start":"2026-04-17T00:54:46.718366Z","end":"2026-04-17T00:54:47.552787Z","steps":["trace[1800569275] 'range keys from in-memory index tree' (duration: 834.098297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:47.552862Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:46.718337Z","time spent":"834.515326ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"info","ts":"2026-04-17T00:54:47.884166Z","caller":"traceutil/trace.go:172","msg":"trace[45021101] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"308.371826ms","start":"2026-04-17T00:54:47.575775Z","end":"2026-04-17T00:54:47.884146Z","steps":["trace[45021101] 'process raft request' (duration: 308.262541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:47.884284Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:47.575760Z","time spent":"308.47721ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":217,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:54:47.885859Z","caller":"traceutil/trace.go:172","msg":"trace[53698109] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"228.285057ms","start":"2026-04-17T00:54:47.657539Z","end":"2026-04-17T00:54:47.885824Z","steps":["trace[53698109] 'process raft request' (duration: 227.890578ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:48.136153Z","caller":"traceutil/trace.go:172","msg":"trace[674555010] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"203.95297ms","start":"2026-04-17T00:54:47.932175Z","end":"2026-04-17T00:54:48.136128Z","steps":["trace[674555010] 'process raft request' (duration: 116.826397ms)","trace[674555010] 'compare' (duration: 86.941954ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:48.140856Z","caller":"traceutil/trace.go:172","msg":"trace[1124785134] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"207.251112ms","start":"2026-04-17T00:54:47.933570Z","end":"2026-04-17T00:54:48.140821Z","steps":["trace[1124785134] 'process raft request' (duration: 207.129056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.367727Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219215532289138,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T00:54:49.481044Z","caller":"traceutil/trace.go:172","msg":"trace[1080322389] linearizableReadLoop","detail":"{readStateIndex:373; appliedIndex:373; }","duration":"613.321329ms","start":"2026-04-17T00:54:48.867684Z","end":"2026-04-17T00:54:49.481006Z","steps":["trace[1080322389] 'read index received' (duration: 613.308768ms)","trace[1080322389] 'applied index is now lower than readState.Index' (duration: 10.631µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:49.481224Z","caller":"traceutil/trace.go:172","msg":"trace[1603171971] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"653.758157ms","start":"2026-04-17T00:54:48.827430Z","end":"2026-04-17T00:54:49.481188Z","steps":["trace[1603171971] 'process raft request' (duration: 653.624101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.481358Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"613.653854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-17T00:54:49.481379Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:48.827414Z","time spent":"653.887142ms","remote":"127.0.0.1:59650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1378,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:54:49.481400Z","caller":"traceutil/trace.go:172","msg":"trace[266150302] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:358; }","duration":"613.720857ms","start":"2026-04-17T00:54:48.867668Z","end":"2026-04-17T00:54:49.481389Z","steps":["trace[266150302] 'agreement among raft nodes before linearized reading' (duration: 613.518418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.481440Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:48.867648Z","time spent":"613.782849ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:54:49.482009Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"214.23629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-17T00:54:49.482057Z","caller":"traceutil/trace.go:172","msg":"trace[177585482] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:358; }","duration":"214.286182ms","start":"2026-04-17T00:54:49.267760Z","end":"2026-04-17T00:54:49.482046Z","steps":["trace[177585482] 'agreement among raft nodes before linearized reading' (duration: 214.136805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.482901Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"514.432765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-04-17T00:54:49.482322Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"114.549377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-17T00:54:49.483363Z","caller":"traceutil/trace.go:172","msg":"trace[300238418] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-cidrs-controller; range_end:; response_count:1; response_revision:358; }","duration":"115.606436ms","start":"2026-04-17T00:54:49.367737Z","end":"2026-04-17T00:54:49.483344Z","steps":["trace[300238418] 'agreement among raft nodes before linearized reading' (duration: 114.330757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.482571Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"364.680921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-17T00:54:49.483468Z","caller":"traceutil/trace.go:172","msg":"trace[1025055577] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:358; }","duration":"365.585633ms","start":"2026-04-17T00:54:49.117873Z","end":"2026-04-17T00:54:49.483459Z","steps":["trace[1025055577] 'agreement among raft nodes before linearized reading' (duration: 364.598177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.483502Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:49.117847Z","time spent":"365.639886ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:54:49.482494Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"564.601651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 ","response":"range_response_count:1 size:238"} {"level":"info","ts":"2026-04-17T00:54:49.483579Z","caller":"traceutil/trace.go:172","msg":"trace[1463865108] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner; range_end:; response_count:1; response_revision:358; }","duration":"565.696341ms","start":"2026-04-17T00:54:48.917873Z","end":"2026-04-17T00:54:49.483569Z","steps":["trace[1463865108] 'agreement among raft nodes before linearized reading' (duration: 563.834736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.483609Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:48.917839Z","time spent":"565.758175ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":260,"request content":"key:\"/registry/serviceaccounts/kube-system/legacy-service-account-token-cleaner\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:54:49.482657Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"265.006429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-17T00:54:49.483858Z","caller":"traceutil/trace.go:172","msg":"trace[1343527827] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:358; }","duration":"266.202264ms","start":"2026-04-17T00:54:49.217643Z","end":"2026-04-17T00:54:49.483846Z","steps":["trace[1343527827] 'agreement among raft nodes before linearized reading' (duration: 264.957616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.482737Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"464.872728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-17T00:54:49.483951Z","caller":"traceutil/trace.go:172","msg":"trace[214471829] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:358; }","duration":"466.085784ms","start":"2026-04-17T00:54:49.017857Z","end":"2026-04-17T00:54:49.483943Z","steps":["trace[214471829] 'agreement among raft nodes before linearized reading' (duration: 464.832826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.483980Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:49.017836Z","time spent":"466.133206ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:54:49.482737Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"315.213692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-17T00:54:49.484248Z","caller":"traceutil/trace.go:172","msg":"trace[1701279070] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:358; }","duration":"316.69537ms","start":"2026-04-17T00:54:49.167508Z","end":"2026-04-17T00:54:49.484204Z","steps":["trace[1701279070] 'agreement among raft nodes before linearized reading' (duration: 315.142369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.484300Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:49.167494Z","time spent":"316.791235ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:54:49.482795Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"413.712071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-17T00:54:49.484391Z","caller":"traceutil/trace.go:172","msg":"trace[328967387] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:358; }","duration":"415.311184ms","start":"2026-04-17T00:54:49.069071Z","end":"2026-04-17T00:54:49.484382Z","steps":["trace[328967387] 'agreement among raft nodes before linearized reading' (duration: 413.545903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.482799Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"163.300303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-17T00:54:49.484505Z","caller":"traceutil/trace.go:172","msg":"trace[325541087] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:358; }","duration":"164.998992ms","start":"2026-04-17T00:54:49.319481Z","end":"2026-04-17T00:54:49.484480Z","steps":["trace[325541087] 'agreement among raft nodes before linearized reading' (duration: 162.906565ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:49.483222Z","caller":"traceutil/trace.go:172","msg":"trace[175859203] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:358; }","duration":"514.811214ms","start":"2026-04-17T00:54:48.968390Z","end":"2026-04-17T00:54:49.483201Z","steps":["trace[175859203] 'agreement among raft nodes before linearized reading' (duration: 514.31368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.484417Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:49.069036Z","time spent":"415.373696ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:54:49.484822Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:48.968357Z","time spent":"516.192088ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:54:49.867129Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"218.899106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" limit:1 ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-04-17T00:54:49.867195Z","caller":"traceutil/trace.go:172","msg":"trace[849143767] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:376; }","duration":"218.97798ms","start":"2026-04-17T00:54:49.648199Z","end":"2026-04-17T00:54:49.867177Z","steps":["trace[849143767] 'agreement among raft nodes before linearized reading' (duration: 71.197181ms)","trace[849143767] 'range keys from in-memory index tree' (duration: 147.604421ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:49.867544Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"148.049011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:54:49.868379Z","caller":"traceutil/trace.go:172","msg":"trace[326731174] linearizableReadLoop","detail":"{readStateIndex:393; appliedIndex:392; }","duration":"149.003966ms","start":"2026-04-17T00:54:49.719352Z","end":"2026-04-17T00:54:49.868356Z","steps":["trace[326731174] 'read index received' (duration: 53.843µs)","trace[326731174] 'applied index is now lower than readState.Index' (duration: 148.948002ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:49.868461Z","caller":"traceutil/trace.go:172","msg":"trace[29778166] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"242.895222ms","start":"2026-04-17T00:54:49.625535Z","end":"2026-04-17T00:54:49.868430Z","steps":["trace[29778166] 'process raft request' (duration: 93.857785ms)","trace[29778166] 'compare' (duration: 147.771548ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:49.868631Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"200.256676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-17T00:54:49.868693Z","caller":"traceutil/trace.go:172","msg":"trace[678741965] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:377; }","duration":"200.323219ms","start":"2026-04-17T00:54:49.668355Z","end":"2026-04-17T00:54:49.868679Z","steps":["trace[678741965] 'agreement among raft nodes before linearized reading' (duration: 200.142301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:49.869262Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"151.194666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" limit:1 ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-17T00:54:49.869351Z","caller":"traceutil/trace.go:172","msg":"trace[107601673] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:377; }","duration":"151.290851ms","start":"2026-04-17T00:54:49.718033Z","end":"2026-04-17T00:54:49.869324Z","steps":["trace[107601673] 'agreement among raft nodes before linearized reading' (duration: 150.517055ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:50.157007Z","caller":"traceutil/trace.go:172","msg":"trace[780827871] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"129.03292ms","start":"2026-04-17T00:54:50.027947Z","end":"2026-04-17T00:54:50.156980Z","steps":["trace[780827871] 'process raft request' (duration: 128.858122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:53.790547Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:53.254382Z","time spent":"536.161579ms","remote":"127.0.0.1:59282","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-17T00:54:54.271507Z","caller":"traceutil/trace.go:172","msg":"trace[1276598337] linearizableReadLoop","detail":"{readStateIndex:438; appliedIndex:438; }","duration":"464.787406ms","start":"2026-04-17T00:54:53.806658Z","end":"2026-04-17T00:54:54.271445Z","steps":["trace[1276598337] 'read index received' (duration: 464.755925ms)","trace[1276598337] 'applied index is now lower than readState.Index' (duration: 27.351µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:54.317194Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"272.929695ms","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-17T00:54:54.317273Z","caller":"traceutil/trace.go:172","msg":"trace[1109563591] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:420; }","duration":"273.02352ms","start":"2026-04-17T00:54:54.044232Z","end":"2026-04-17T00:54:54.317256Z","steps":["trace[1109563591] 'range keys from in-memory index tree' (duration: 272.879593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:54.317294Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"510.619964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:54:54.317382Z","caller":"traceutil/trace.go:172","msg":"trace[779409421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:420; }","duration":"510.711838ms","start":"2026-04-17T00:54:53.806647Z","end":"2026-04-17T00:54:54.317359Z","steps":["trace[779409421] 'agreement among raft nodes before linearized reading' (duration: 464.917571ms)","trace[779409421] 'range keys from in-memory index tree' (duration: 45.65696ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:54.317442Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:53.806630Z","time spent":"510.799873ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T00:54:54.318144Z","caller":"traceutil/trace.go:172","msg":"trace[557782419] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"401.649241ms","start":"2026-04-17T00:54:53.916475Z","end":"2026-04-17T00:54:54.318124Z","steps":["trace[557782419] 'process raft request' (duration: 401.122686ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:54.318228Z","caller":"traceutil/trace.go:172","msg":"trace[1338534313] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"729.095885ms","start":"2026-04-17T00:54:53.589110Z","end":"2026-04-17T00:54:54.318206Z","steps":["trace[1338534313] 'process raft request' (duration: 682.521183ms)","trace[1338534313] 'compare' (duration: 45.506982ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:54.318271Z","caller":"traceutil/trace.go:172","msg":"trace[199422611] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"526.465113ms","start":"2026-04-17T00:54:53.791791Z","end":"2026-04-17T00:54:54.318256Z","steps":["trace[199422611] 'process raft request' (duration: 525.709197ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:54.318268Z","caller":"traceutil/trace.go:172","msg":"trace[988076037] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"397.783001ms","start":"2026-04-17T00:54:53.920407Z","end":"2026-04-17T00:54:54.318190Z","steps":["trace[988076037] 'process raft request' (duration: 397.242366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:54.318347Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:53.589081Z","time spent":"729.19746ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:54:54.318386Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:53.791771Z","time spent":"526.538456ms","remote":"127.0.0.1:59282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:54:54.318554Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:53.920392Z","time spent":"397.996682ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:54:54.318858Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:53.916447Z","time spent":"401.803709ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:54:54.481434Z","caller":"traceutil/trace.go:172","msg":"trace[1732230102] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"151.516261ms","start":"2026-04-17T00:54:54.329890Z","end":"2026-04-17T00:54:54.481406Z","steps":["trace[1732230102] 'process raft request' (duration: 132.743935ms)","trace[1732230102] 'compare' (duration: 18.613179ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:55.193900Z","caller":"traceutil/trace.go:172","msg":"trace[968409137] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:444; }","duration":"149.558745ms","start":"2026-04-17T00:54:55.044308Z","end":"2026-04-17T00:54:55.193866Z","steps":["trace[968409137] 'read index received' (duration: 149.545154ms)","trace[968409137] 'applied index is now lower than readState.Index' (duration: 11.791µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:55.194116Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"149.778585ms","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-17T00:54:55.194185Z","caller":"traceutil/trace.go:172","msg":"trace[382485803] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:426; }","duration":"149.901111ms","start":"2026-04-17T00:54:55.044269Z","end":"2026-04-17T00:54:55.194170Z","steps":["trace[382485803] 'agreement among raft nodes before linearized reading' (duration: 149.717612ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:55.194185Z","caller":"traceutil/trace.go:172","msg":"trace[664274567] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"338.676763ms","start":"2026-04-17T00:54:54.855487Z","end":"2026-04-17T00:54:55.194163Z","steps":["trace[664274567] 'process raft request' (duration: 338.478134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:55.194347Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:54.855463Z","time spent":"338.80774ms","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4736,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:54:55.384633Z","caller":"traceutil/trace.go:172","msg":"trace[213900620] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:445; }","duration":"185.956517ms","start":"2026-04-17T00:54:55.198648Z","end":"2026-04-17T00:54:55.384605Z","steps":["trace[213900620] 'read index received' (duration: 185.947607ms)","trace[213900620] 'applied index is now lower than readState.Index' (duration: 7.63µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:55.434819Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"236.147904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-controller\" limit:1 ","response":"range_response_count:1 size:4688"} {"level":"info","ts":"2026-04-17T00:54:55.434908Z","caller":"traceutil/trace.go:172","msg":"trace[1432719211] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-controller; range_end:; response_count:1; response_revision:427; }","duration":"236.252559ms","start":"2026-04-17T00:54:55.198633Z","end":"2026-04-17T00:54:55.434886Z","steps":["trace[1432719211] 'agreement among raft nodes before linearized reading' (duration: 186.074542ms)","trace[1432719211] 'range keys from in-memory index tree' (duration: 49.968737ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:55.434970Z","caller":"traceutil/trace.go:172","msg":"trace[1633936913] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"522.253258ms","start":"2026-04-17T00:54:54.912690Z","end":"2026-04-17T00:54:55.434943Z","steps":["trace[1633936913] 'process raft request' (duration: 471.952555ms)","trace[1633936913] 'compare' (duration: 50.155026ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:54:55.435185Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:54:54.912664Z","time spent":"522.413655ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:54:58.476114Z","caller":"traceutil/trace.go:172","msg":"trace[1089360684] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"144.507132ms","start":"2026-04-17T00:54:58.331586Z","end":"2026-04-17T00:54:58.476093Z","steps":["trace[1089360684] 'process raft request' (duration: 144.367496ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:58.627342Z","caller":"traceutil/trace.go:172","msg":"trace[1111012708] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"293.79213ms","start":"2026-04-17T00:54:58.333527Z","end":"2026-04-17T00:54:58.627319Z","steps":["trace[1111012708] 'process raft request' (duration: 286.840982ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:04.405028Z","caller":"traceutil/trace.go:172","msg":"trace[1012223563] linearizableReadLoop","detail":"{readStateIndex:459; appliedIndex:459; }","duration":"361.176384ms","start":"2026-04-17T00:55:04.043803Z","end":"2026-04-17T00:55:04.404979Z","steps":["trace[1012223563] 'read index received' (duration: 361.162733ms)","trace[1012223563] 'applied index is now lower than readState.Index' (duration: 12.141µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:04.405175Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"361.345151ms","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-17T00:55:04.405209Z","caller":"traceutil/trace.go:172","msg":"trace[558273620] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:439; }","duration":"361.402594ms","start":"2026-04-17T00:55:04.043795Z","end":"2026-04-17T00:55:04.405198Z","steps":["trace[558273620] 'agreement among raft nodes before linearized reading' (duration: 361.308609ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:04.405201Z","caller":"traceutil/trace.go:172","msg":"trace[865751850] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"463.008796ms","start":"2026-04-17T00:55:03.942170Z","end":"2026-04-17T00:55:04.405179Z","steps":["trace[865751850] 'process raft request' (duration: 462.87811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:04.405337Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:03.942146Z","time spent":"463.120341ms","remote":"127.0.0.1:60030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:55:04.502189Z","caller":"traceutil/trace.go:172","msg":"trace[822549627] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"154.41039ms","start":"2026-04-17T00:55:04.347762Z","end":"2026-04-17T00:55:04.502172Z","steps":["trace[822549627] 'process raft request' (duration: 154.268193ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:04.511851Z","caller":"traceutil/trace.go:172","msg":"trace[1543638746] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"101.214248ms","start":"2026-04-17T00:55:04.410618Z","end":"2026-04-17T00:55:04.511833Z","steps":["trace[1543638746] 'process raft request' (duration: 97.417187ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:06.854815Z","caller":"traceutil/trace.go:172","msg":"trace[447290568] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"337.566402ms","start":"2026-04-17T00:55:06.517225Z","end":"2026-04-17T00:55:06.854792Z","steps":["trace[447290568] 'process raft request' (duration: 337.389023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:06.854969Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:06.517202Z","time spent":"337.694728ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:55:06.860808Z","caller":"traceutil/trace.go:172","msg":"trace[992492891] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"202.148225ms","start":"2026-04-17T00:55:06.658644Z","end":"2026-04-17T00:55:06.860793Z","steps":["trace[992492891] 'process raft request' (duration: 202.050311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:11.153514Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.601262ms","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-17T00:55:11.153598Z","caller":"traceutil/trace.go:172","msg":"trace[1314350370] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:476; }","duration":"109.690717ms","start":"2026-04-17T00:55:11.043890Z","end":"2026-04-17T00:55:11.153581Z","steps":["trace[1314350370] 'agreement among raft nodes before linearized reading' (duration: 28.06725ms)","trace[1314350370] 'range keys from in-memory index tree' (duration: 81.517241ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:55:11.153882Z","caller":"traceutil/trace.go:172","msg":"trace[969724756] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"282.095882ms","start":"2026-04-17T00:55:10.871774Z","end":"2026-04-17T00:55:11.153870Z","steps":["trace[969724756] 'process raft request' (duration: 200.228473ms)","trace[969724756] 'compare' (duration: 81.217637ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:55:21.055840Z","caller":"traceutil/trace.go:172","msg":"trace[1682377370] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"139.197449ms","start":"2026-04-17T00:55:20.916621Z","end":"2026-04-17T00:55:21.055819Z","steps":["trace[1682377370] 'process raft request' (duration: 138.693304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:22.372387Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"328.210376ms","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-17T00:55:22.372450Z","caller":"traceutil/trace.go:172","msg":"trace[1581442270] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:523; }","duration":"328.280124ms","start":"2026-04-17T00:55:22.044156Z","end":"2026-04-17T00:55:22.372436Z","steps":["trace[1581442270] 'range keys from in-memory index tree' (duration: 328.165756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:22.571772Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.377280926s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T00:55:22.572315Z","caller":"traceutil/trace.go:172","msg":"trace[1766545362] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:546; }","duration":"199.745397ms","start":"2026-04-17T00:55:22.372480Z","end":"2026-04-17T00:55:22.572225Z","steps":["trace[1766545362] 'read index received' (duration: 199.670939ms)","trace[1766545362] 'applied index is now lower than readState.Index' (duration: 71.698µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:55:22.572654Z","caller":"traceutil/trace.go:172","msg":"trace[2126740265] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"1.378219211s","start":"2026-04-17T00:55:21.194404Z","end":"2026-04-17T00:55:22.572623Z","steps":["trace[2126740265] 'process raft request' (duration: 1.377977157s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:22.572860Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.194386Z","time spent":"1.378372229s","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:55:22.572924Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"200.413683ms","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-17T00:55:22.572975Z","caller":"traceutil/trace.go:172","msg":"trace[747172744] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:523; }","duration":"200.486661ms","start":"2026-04-17T00:55:22.372473Z","end":"2026-04-17T00:55:22.572960Z","steps":["trace[747172744] 'agreement among raft nodes before linearized reading' (duration: 199.952943ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:22.587227Z","caller":"traceutil/trace.go:172","msg":"trace[2024010236] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"1.324369592s","start":"2026-04-17T00:55:21.262828Z","end":"2026-04-17T00:55:22.587197Z","steps":["trace[2024010236] 'process raft request' (duration: 1.324092078s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:22.587482Z","caller":"traceutil/trace.go:172","msg":"trace[1543526574] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"1.324525586s","start":"2026-04-17T00:55:21.262878Z","end":"2026-04-17T00:55:22.587403Z","steps":["trace[1543526574] 'process raft request' (duration: 1.324220272s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:22.587655Z","caller":"traceutil/trace.go:172","msg":"trace[911588478] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.321766281s","start":"2026-04-17T00:55:21.265850Z","end":"2026-04-17T00:55:22.587616Z","steps":["trace[911588478] 'process raft request' (duration: 1.32128563s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:22.587708Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.262797Z","time spent":"1.324703267s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:55:22.587946Z","caller":"traceutil/trace.go:172","msg":"trace[263932924] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.317748707s","start":"2026-04-17T00:55:21.270183Z","end":"2026-04-17T00:55:22.587931Z","steps":["trace[263932924] 'process raft request' (duration: 1.317189119s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:22.588037Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.262847Z","time spent":"1.324687264s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:55:22.588244Z","caller":"traceutil/trace.go:172","msg":"trace[2027397447] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.307129746s","start":"2026-04-17T00:55:21.281098Z","end":"2026-04-17T00:55:22.588228Z","steps":["trace[2027397447] 'process raft request' (duration: 1.306505849s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:22.588313Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.281074Z","time spent":"1.307206775s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:55:22.588423Z","caller":"traceutil/trace.go:172","msg":"trace[1530780012] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"1.297861647s","start":"2026-04-17T00:55:21.290551Z","end":"2026-04-17T00:55:22.588412Z","steps":["trace[1530780012] 'process raft request' (duration: 1.297658721s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:22.588569Z","caller":"traceutil/trace.go:172","msg":"trace[1698879241] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.289976617s","start":"2026-04-17T00:55:21.298580Z","end":"2026-04-17T00:55:22.588557Z","steps":["trace[1698879241] 'process raft request' (duration: 1.289700022s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:22.588649Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.290532Z","time spent":"1.297964606s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:55:22.588704Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.298552Z","time spent":"1.290123575s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:55:22.588662Z","caller":"traceutil/trace.go:172","msg":"trace[278022459] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.278302125s","start":"2026-04-17T00:55:21.310346Z","end":"2026-04-17T00:55:22.588648Z","steps":["trace[278022459] 'process raft request' (duration: 1.277981141s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:22.588951Z","caller":"traceutil/trace.go:172","msg":"trace[1192719700] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"1.269795402s","start":"2026-04-17T00:55:21.319124Z","end":"2026-04-17T00:55:22.588919Z","steps":["trace[1192719700] 'process raft request' (duration: 1.269281802s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:22.588929Z","caller":"traceutil/trace.go:172","msg":"trace[1746116297] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.151604343s","start":"2026-04-17T00:55:21.437312Z","end":"2026-04-17T00:55:22.588916Z","steps":["trace[1746116297] 'process raft request' (duration: 1.151420797s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:22.589005Z","caller":"traceutil/trace.go:172","msg":"trace[394707615] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.245903563s","start":"2026-04-17T00:55:21.343090Z","end":"2026-04-17T00:55:22.588993Z","steps":["trace[394707615] 'process raft request' (duration: 1.245454302s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:22.589036Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.310308Z","time spent":"1.27868492s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:55:22.588392Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.270159Z","time spent":"1.318209689s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:55:22.589101Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.319097Z","time spent":"1.269923901s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:55:22.589065Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.343054Z","time spent":"1.245986343s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:55:22.588336Z","caller":"traceutil/trace.go:172","msg":"trace[990866096] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.304773376s","start":"2026-04-17T00:55:21.283525Z","end":"2026-04-17T00:55:22.588299Z","steps":["trace[990866096] 'process raft request' (duration: 1.30459774s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:22.592143Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.283505Z","time spent":"1.30853284s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:55:22.589271Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.437272Z","time spent":"1.151932519s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T00:55:22.589367Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:21.265839Z","time spent":"1.323436486s","remote":"127.0.0.1:59324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:55:23.245152Z","caller":"traceutil/trace.go:172","msg":"trace[820767635] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"105.550259ms","start":"2026-04-17T00:55:23.139586Z","end":"2026-04-17T00:55:23.245136Z","steps":["trace[820767635] 'process raft request' (duration: 99.900091ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:26.534659Z","caller":"traceutil/trace.go:172","msg":"trace[31748535] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"268.025129ms","start":"2026-04-17T00:55:26.266619Z","end":"2026-04-17T00:55:26.534644Z","steps":["trace[31748535] 'process raft request' (duration: 267.899111ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:26.546375Z","caller":"traceutil/trace.go:172","msg":"trace[1480450611] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"233.473193ms","start":"2026-04-17T00:55:26.312893Z","end":"2026-04-17T00:55:26.546366Z","steps":["trace[1480450611] 'process raft request' (duration: 233.421174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:29.497369Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219215532289636,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T00:55:29.729572Z","caller":"traceutil/trace.go:172","msg":"trace[1874116244] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:653; }","duration":"732.623098ms","start":"2026-04-17T00:55:28.996905Z","end":"2026-04-17T00:55:29.729528Z","steps":["trace[1874116244] 'read index received' (duration: 732.602739ms)","trace[1874116244] 'applied index is now lower than readState.Index' (duration: 16.329µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:29.729814Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"732.889465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7vtsg\" limit:1 ","response":"range_response_count:1 size:18345"} {"level":"info","ts":"2026-04-17T00:55:29.729894Z","caller":"traceutil/trace.go:172","msg":"trace[711014098] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7vtsg; range_end:; response_count:1; response_revision:625; }","duration":"732.987433ms","start":"2026-04-17T00:55:28.996890Z","end":"2026-04-17T00:55:29.729877Z","steps":["trace[711014098] 'agreement among raft nodes before linearized reading' (duration: 732.744657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:29.729927Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:28.996865Z","time spent":"733.055431ms","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18367,"request content":"key:\"/registry/pods/kube-system/cilium-7vtsg\" limit:1 "} {"level":"info","ts":"2026-04-17T00:55:29.732078Z","caller":"traceutil/trace.go:172","msg":"trace[1353703738] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"783.022541ms","start":"2026-04-17T00:55:28.949036Z","end":"2026-04-17T00:55:29.732059Z","steps":["trace[1353703738] 'process raft request' (duration: 780.740033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:29.732251Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:28.948992Z","time spent":"783.164098ms","remote":"127.0.0.1:59378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:55:29.898046Z","caller":"traceutil/trace.go:172","msg":"trace[1231106252] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:654; }","duration":"168.337147ms","start":"2026-04-17T00:55:29.729681Z","end":"2026-04-17T00:55:29.898018Z","steps":["trace[1231106252] 'read index received' (duration: 168.329997ms)","trace[1231106252] 'applied index is now lower than readState.Index' (duration: 6.32µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:30.088462Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"432.25265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:30.088562Z","caller":"traceutil/trace.go:172","msg":"trace[832117558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"432.366209ms","start":"2026-04-17T00:55:29.656172Z","end":"2026-04-17T00:55:30.088538Z","steps":["trace[832117558] 'agreement among raft nodes before linearized reading' (duration: 241.956262ms)","trace[832117558] 'range keys from in-memory index tree' (duration: 190.252399ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:30.088610Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:29.656135Z","time spent":"432.465677ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T00:55:30.089311Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.045052521s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T00:55:30.089352Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"191.117308ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:55:30.089485Z","caller":"traceutil/trace.go:172","msg":"trace[1818928394] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.006104694s","start":"2026-04-17T00:55:29.083361Z","end":"2026-04-17T00:55:30.089466Z","steps":["trace[1818928394] 'process raft request' (duration: 814.779649ms)","trace[1818928394] 'compare' (duration: 190.944351ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:55:30.089494Z","caller":"traceutil/trace.go:172","msg":"trace[1939436986] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:626; }","duration":"1.045199349s","start":"2026-04-17T00:55:29.044207Z","end":"2026-04-17T00:55:30.089406Z","steps":["trace[1939436986] 'agreement among raft nodes before linearized reading' (duration: 853.911674ms)","trace[1939436986] 'range keys from in-memory index tree' (duration: 191.096098ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:30.089561Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:29.083315Z","time spent":"1.006217173s","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:55:30.590955Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219215532289642,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T00:55:30.773241Z","caller":"traceutil/trace.go:172","msg":"trace[808384649] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:655; }","duration":"682.684348ms","start":"2026-04-17T00:55:30.090524Z","end":"2026-04-17T00:55:30.773208Z","steps":["trace[808384649] 'read index received' (duration: 682.671158ms)","trace[808384649] 'applied index is now lower than readState.Index' (duration: 11.48µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:30.995572Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"905.028254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:30.995667Z","caller":"traceutil/trace.go:172","msg":"trace[80648720] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"905.126293ms","start":"2026-04-17T00:55:30.090519Z","end":"2026-04-17T00:55:30.995645Z","steps":["trace[80648720] 'agreement among raft nodes before linearized reading' (duration: 682.826306ms)","trace[80648720] 'range keys from in-memory index tree' (duration: 222.171838ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:30.995678Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"222.358716ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-17T00:55:30.995715Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:30.090498Z","time spent":"905.205492ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T00:55:30.995941Z","caller":"traceutil/trace.go:172","msg":"trace[1958654795] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"393.351717ms","start":"2026-04-17T00:55:30.602573Z","end":"2026-04-17T00:55:30.995925Z","steps":["trace[1958654795] 'process raft request' (duration: 393.275958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:30.996023Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:30.602546Z","time spent":"393.435425ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:55:30.996233Z","caller":"traceutil/trace.go:172","msg":"trace[1351346703] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.198725567s","start":"2026-04-17T00:55:29.797493Z","end":"2026-04-17T00:55:30.996218Z","steps":["trace[1351346703] 'process raft request' (duration: 1.198247802s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:30.996305Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:29.797467Z","time spent":"1.198803855s","remote":"127.0.0.1:60128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:55:30.996373Z","caller":"traceutil/trace.go:172","msg":"trace[1730386926] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"223.027628ms","start":"2026-04-17T00:55:30.773311Z","end":"2026-04-17T00:55:30.996338Z","steps":["trace[1730386926] 'read index received' (duration: 28.644729ms)","trace[1730386926] 'applied index is now lower than readState.Index' (duration: 194.379859ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:55:30.996412Z","caller":"traceutil/trace.go:172","msg":"trace[68631716] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.24557585s","start":"2026-04-17T00:55:29.750803Z","end":"2026-04-17T00:55:30.996379Z","steps":["trace[68631716] 'process raft request' (duration: 1.022446034s)","trace[68631716] 'compare' (duration: 222.203698ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:30.996490Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"904.676319ms","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-17T00:55:30.996527Z","caller":"traceutil/trace.go:172","msg":"trace[691535666] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:630; }","duration":"904.717179ms","start":"2026-04-17T00:55:30.091798Z","end":"2026-04-17T00:55:30.996516Z","steps":["trace[691535666] 'agreement among raft nodes before linearized reading' (duration: 904.64876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:30.996632Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:29.750760Z","time spent":"1.245775388s","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18502,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:55:32.156235Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219215532289648,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:55:32.657298Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219215532289648,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:55:33.157512Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219215532289648,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:55:33.230381Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.186225189s","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-17T00:55:33.230446Z","caller":"traceutil/trace.go:172","msg":"trace[1428910921] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:630; }","duration":"1.186300518s","start":"2026-04-17T00:55:32.044131Z","end":"2026-04-17T00:55:33.230431Z","steps":["trace[1428910921] 'range keys from in-memory index tree' (duration: 1.186177099s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:33.473025Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.07954479s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T00:55:33.473255Z","caller":"traceutil/trace.go:172","msg":"trace[1957512738] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:658; }","duration":"1.817945861s","start":"2026-04-17T00:55:31.655273Z","end":"2026-04-17T00:55:33.473219Z","steps":["trace[1957512738] 'read index received' (duration: 1.817929361s)","trace[1957512738] 'applied index is now lower than readState.Index' (duration: 14.22µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:33.473448Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.818154408s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:33.473484Z","caller":"traceutil/trace.go:172","msg":"trace[570465419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"1.818213358s","start":"2026-04-17T00:55:31.655260Z","end":"2026-04-17T00:55:33.473474Z","steps":["trace[570465419] 'agreement among raft nodes before linearized reading' (duration: 1.818104539s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:33.473517Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:31.655237Z","time spent":"1.818273947s","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T00:55:33.474337Z","caller":"traceutil/trace.go:172","msg":"trace[992816201] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"2.082990838s","start":"2026-04-17T00:55:31.391296Z","end":"2026-04-17T00:55:33.474287Z","steps":["trace[992816201] 'process raft request' (duration: 2.082443815s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:33.474384Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"872.378079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:33.474432Z","caller":"traceutil/trace.go:172","msg":"trace[81418515] range","detail":"{range_begin:/registry/daemonsets; range_end:; response_count:0; response_revision:631; }","duration":"872.443858ms","start":"2026-04-17T00:55:32.601976Z","end":"2026-04-17T00:55:33.474419Z","steps":["trace[81418515] 'agreement among raft nodes before linearized reading' (duration: 872.340188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:33.474464Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:32.601955Z","time spent":"872.501168ms","remote":"127.0.0.1:60060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":27,"request content":"key:\"/registry/daemonsets\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:55:33.478361Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"222.538174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-17T00:55:33.478472Z","caller":"traceutil/trace.go:172","msg":"trace[744036210] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:631; }","duration":"222.627253ms","start":"2026-04-17T00:55:33.255804Z","end":"2026-04-17T00:55:33.478432Z","steps":["trace[744036210] 'agreement among raft nodes before linearized reading' (duration: 218.835984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:33.478981Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"645.389417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T00:55:33.478986Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:31.391265Z","time spent":"2.083128817s","remote":"127.0.0.1:59378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:55:33.479023Z","caller":"traceutil/trace.go:172","msg":"trace[582211904] range","detail":"{range_begin:/registry/statefulsets; range_end:; response_count:0; response_revision:631; }","duration":"645.442246ms","start":"2026-04-17T00:55:32.833570Z","end":"2026-04-17T00:55:33.479012Z","steps":["trace[582211904] 'agreement among raft nodes before linearized reading' (duration: 645.272298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:33.479058Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:32.833554Z","time spent":"645.497946ms","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":27,"request content":"key:\"/registry/statefulsets\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:55:33.478819Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"248.322988ms","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-17T00:55:33.479926Z","caller":"traceutil/trace.go:172","msg":"trace[1209901812] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:631; }","duration":"249.381585ms","start":"2026-04-17T00:55:33.230481Z","end":"2026-04-17T00:55:33.479863Z","steps":["trace[1209901812] 'agreement among raft nodes before linearized reading' (duration: 248.197869ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:33.479998Z","caller":"traceutil/trace.go:172","msg":"trace[1697364336] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"478.299787ms","start":"2026-04-17T00:55:33.001664Z","end":"2026-04-17T00:55:33.479964Z","steps":["trace[1697364336] 'process raft request' (duration: 478.202647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:33.480113Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:33.001637Z","time spent":"478.414416ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:55:33.480412Z","caller":"traceutil/trace.go:172","msg":"trace[1042411267] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"1.38431045s","start":"2026-04-17T00:55:32.096077Z","end":"2026-04-17T00:55:33.480388Z","steps":["trace[1042411267] 'process raft request' (duration: 1.378631262s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:33.480563Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:32.096002Z","time spent":"1.384487328s","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:55:34.238919Z","caller":"traceutil/trace.go:172","msg":"trace[1485423496] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"211.34092ms","start":"2026-04-17T00:55:34.027551Z","end":"2026-04-17T00:55:34.238892Z","steps":["trace[1485423496] 'process raft request' (duration: 211.147581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:36.878872Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"222.707677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:36.878937Z","caller":"traceutil/trace.go:172","msg":"trace[1187595437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"222.777777ms","start":"2026-04-17T00:55:36.656147Z","end":"2026-04-17T00:55:36.878925Z","steps":["trace[1187595437] 'range keys from in-memory index tree' (duration: 222.559659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:36.879068Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"224.319733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deviceclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:36.879147Z","caller":"traceutil/trace.go:172","msg":"trace[1842027413] range","detail":"{range_begin:/registry/deviceclasses; range_end:; response_count:0; response_revision:653; }","duration":"224.432082ms","start":"2026-04-17T00:55:36.654700Z","end":"2026-04-17T00:55:36.879132Z","steps":["trace[1842027413] 'range keys from in-memory index tree' (duration: 224.208574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:36.879123Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"361.284794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceclaimtemplates\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:36.879208Z","caller":"traceutil/trace.go:172","msg":"trace[895921848] range","detail":"{range_begin:/registry/resourceclaimtemplates; range_end:; response_count:0; response_revision:653; }","duration":"361.380453ms","start":"2026-04-17T00:55:36.517809Z","end":"2026-04-17T00:55:36.879189Z","steps":["trace[895921848] 'range keys from in-memory index tree' (duration: 361.175004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:36.879246Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:36.517786Z","time spent":"361.451532ms","remote":"127.0.0.1:60262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/resourceclaimtemplates\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:55:46.523132Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36700","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:46.535461Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36720","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:46.628125Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36734","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:46.673666Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36750","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:46.698634Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36766","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-17T00:55:46.774448Z","caller":"traceutil/trace.go:172","msg":"trace[1764521299] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"100.967123ms","start":"2026-04-17T00:55:46.673460Z","end":"2026-04-17T00:55:46.774427Z","steps":["trace[1764521299] 'process raft request' (duration: 100.658734ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:46.774569Z","caller":"traceutil/trace.go:172","msg":"trace[868535195] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"100.012564ms","start":"2026-04-17T00:55:46.674537Z","end":"2026-04-17T00:55:46.774550Z","steps":["trace[868535195] 'process raft request' (duration: 99.772075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:46.824088Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:36780","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:48.844403Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60592","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:48.857902Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60622","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:48.874151Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60624","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:48.898664Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60638","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:48.918756Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60658","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:48.934621Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60682","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:48.961669Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60694","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:48.999196Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60714","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.020435Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60722","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.039241Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60742","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.059163Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60758","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.078218Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60774","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.103229Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60784","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.123000Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60828","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.166777Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60844","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.246249Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60858","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.273235Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60880","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.296504Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60902","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.316285Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60918","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.395020Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60936","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.565853Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60978","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.580321Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60984","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.595084Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32768","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.608877Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32788","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.628385Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32818","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.645628Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32832","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.655506Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32860","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:49.669300Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32884","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-17T00:55:57.204030Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"171.300553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T00:55:57.204060Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"159.000452ms","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-17T00:55:57.204127Z","caller":"traceutil/trace.go:172","msg":"trace[2131994460] range","detail":"{range_begin:/registry/flowschemas; range_end:; response_count:0; response_revision:802; }","duration":"171.420934ms","start":"2026-04-17T00:55:57.032685Z","end":"2026-04-17T00:55:57.204106Z","steps":["trace[2131994460] 'range keys from in-memory index tree' (duration: 171.161462ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:55:57.204156Z","caller":"traceutil/trace.go:172","msg":"trace[1695709401] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:802; }","duration":"159.115832ms","start":"2026-04-17T00:55:57.045021Z","end":"2026-04-17T00:55:57.204137Z","steps":["trace[1695709401] 'range keys from in-memory index tree' (duration: 158.93024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:58.690228Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219215532290147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:55:59.191388Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219215532290147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:55:59.439458Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.269698966s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T00:55:59.439836Z","caller":"traceutil/trace.go:172","msg":"trace[1624722424] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:847; }","duration":"1.249590256s","start":"2026-04-17T00:55:58.190175Z","end":"2026-04-17T00:55:59.439765Z","steps":["trace[1624722424] 'read index received' (duration: 1.249580916s)","trace[1624722424] 'applied index is now lower than readState.Index' (duration: 7.37µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:59.439991Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.249789987s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:59.440074Z","caller":"traceutil/trace.go:172","msg":"trace[1068827103] range","detail":"{range_begin:/registry/persistentvolumes; range_end:; response_count:0; response_revision:812; }","duration":"1.249887048s","start":"2026-04-17T00:55:58.190169Z","end":"2026-04-17T00:55:59.440057Z","steps":["trace[1068827103] 'agreement among raft nodes before linearized reading' (duration: 1.249738647s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:59.440121Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:58.190151Z","time spent":"1.249960088s","remote":"127.0.0.1:59492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes\" limit:1 "} {"level":"info","ts":"2026-04-17T00:55:59.440259Z","caller":"traceutil/trace.go:172","msg":"trace[437018811] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"1.270644112s","start":"2026-04-17T00:55:58.169602Z","end":"2026-04-17T00:55:59.440247Z","steps":["trace[437018811] 'process raft request' (duration: 1.270376001s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:59.440409Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:58.169578Z","time spent":"1.270722033s","remote":"127.0.0.1:59544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4551,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:55:59.460599Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"826.184702ms","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-17T00:55:59.460656Z","caller":"traceutil/trace.go:172","msg":"trace[1367610663] range","detail":"{range_begin:/registry/namespaces; range_end:; response_count:0; response_revision:813; }","duration":"826.244373ms","start":"2026-04-17T00:55:58.634399Z","end":"2026-04-17T00:55:59.460643Z","steps":["trace[1367610663] 'agreement among raft nodes before linearized reading' (duration: 826.151032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:55:59.460725Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:58.634374Z","time spent":"826.305053ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:55:59.608421Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"147.815331ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-04-17T00:55:59.608559Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"564.113983ms","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-17T00:55:59.608651Z","caller":"traceutil/trace.go:172","msg":"trace[574379523] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:813; }","duration":"564.208404ms","start":"2026-04-17T00:55:59.044416Z","end":"2026-04-17T00:55:59.608624Z","steps":["trace[574379523] 'agreement among raft nodes before linearized reading' (duration: 416.498364ms)","trace[574379523] 'range keys from in-memory index tree' (duration: 147.575039ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:59.608641Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"952.353802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:59.608717Z","caller":"traceutil/trace.go:172","msg":"trace[1674625053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:813; }","duration":"952.432962ms","start":"2026-04-17T00:55:58.656261Z","end":"2026-04-17T00:55:59.608694Z","steps":["trace[1674625053] 'agreement among raft nodes before linearized reading' (duration: 804.706883ms)","trace[1674625053] 'range keys from in-memory index tree' (duration: 147.621939ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:59.608756Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:58.656247Z","time spent":"952.501204ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T00:55:59.608740Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"476.255636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattributesclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:59.608832Z","caller":"traceutil/trace.go:172","msg":"trace[2034671578] range","detail":"{range_begin:/registry/volumeattributesclasses; range_end:; response_count:0; response_revision:813; }","duration":"476.350436ms","start":"2026-04-17T00:55:59.132457Z","end":"2026-04-17T00:55:59.608807Z","steps":["trace[2034671578] 'agreement among raft nodes before linearized reading' (duration: 328.515865ms)","trace[2034671578] 'range keys from in-memory index tree' (duration: 147.711949ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:55:59.608872Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:55:59.132434Z","time spent":"476.428887ms","remote":"127.0.0.1:59940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattributesclasses\" limit:1 "} {"level":"warn","ts":"2026-04-17T00:55:59.608870Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"205.110135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:55:59.608928Z","caller":"traceutil/trace.go:172","msg":"trace[266311362] range","detail":"{range_begin:/registry/certificatesigningrequests; range_end:; response_count:0; response_revision:813; }","duration":"205.168876ms","start":"2026-04-17T00:55:59.403741Z","end":"2026-04-17T00:55:59.608910Z","steps":["trace[266311362] 'agreement among raft nodes before linearized reading' (duration: 57.199863ms)","trace[266311362] 'range keys from in-memory index tree' (duration: 147.873061ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:56:09.835970Z","caller":"traceutil/trace.go:172","msg":"trace[2007261964] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"149.927695ms","start":"2026-04-17T00:56:09.686019Z","end":"2026-04-17T00:56:09.835947Z","steps":["trace[2007261964] 'process raft request' (duration: 114.653976ms)","trace[2007261964] 'compare' (duration: 35.157918ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:56:35.724457Z","caller":"traceutil/trace.go:172","msg":"trace[2128973764] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"162.710155ms","start":"2026-04-17T00:56:35.561695Z","end":"2026-04-17T00:56:35.724406Z","steps":["trace[2128973764] 'process raft request' (duration: 162.557341ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:35.908290Z","caller":"traceutil/trace.go:172","msg":"trace[2068514674] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"118.815736ms","start":"2026-04-17T00:56:35.789438Z","end":"2026-04-17T00:56:35.908254Z","steps":["trace[2068514674] 'process raft request' (duration: 52.701004ms)","trace[2068514674] 'compare' (duration: 65.861307ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:56:36.184062Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"138.252792ms","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-17T00:56:36.184456Z","caller":"traceutil/trace.go:172","msg":"trace[759370054] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:952; }","duration":"138.342944ms","start":"2026-04-17T00:56:36.045781Z","end":"2026-04-17T00:56:36.184124Z","steps":["trace[759370054] 'range keys from in-memory index tree' (duration: 138.20127ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:37.993824Z","caller":"traceutil/trace.go:172","msg":"trace[219010668] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"263.708526ms","start":"2026-04-17T00:56:37.730095Z","end":"2026-04-17T00:56:37.993803Z","steps":["trace[219010668] 'process raft request' (duration: 263.554593ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:38.030910Z","caller":"traceutil/trace.go:172","msg":"trace[2125592320] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"118.041881ms","start":"2026-04-17T00:56:37.912637Z","end":"2026-04-17T00:56:38.030679Z","steps":["trace[2125592320] 'process raft request' (duration: 117.869807ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:38.106437Z","caller":"traceutil/trace.go:172","msg":"trace[1640238269] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"110.121222ms","start":"2026-04-17T00:56:37.996292Z","end":"2026-04-17T00:56:38.106413Z","steps":["trace[1640238269] 'process raft request' (duration: 76.537323ms)","trace[1640238269] 'compare' (duration: 33.045297ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:56:38.467482Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"115.417817ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-17T00:56:38.467785Z","caller":"traceutil/trace.go:172","msg":"trace[1414845878] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"121.521018ms","start":"2026-04-17T00:56:38.346247Z","end":"2026-04-17T00:56:38.467768Z","steps":["trace[1414845878] 'process raft request' (duration: 121.364524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:56:38.640227Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"267.841033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/servicecidrs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:56:38.640325Z","caller":"traceutil/trace.go:172","msg":"trace[1953476883] range","detail":"{range_begin:/registry/servicecidrs; range_end:; response_count:0; response_revision:958; }","duration":"267.964436ms","start":"2026-04-17T00:56:38.372334Z","end":"2026-04-17T00:56:38.640298Z","steps":["trace[1953476883] 'agreement among raft nodes before linearized reading' (duration: 95.758662ms)","trace[1953476883] 'range keys from in-memory index tree' (duration: 172.035531ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:56:44.333166Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"200.778232ms","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-17T00:56:44.333272Z","caller":"traceutil/trace.go:172","msg":"trace[1695820414] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:968; }","duration":"200.899175ms","start":"2026-04-17T00:56:44.132347Z","end":"2026-04-17T00:56:44.333247Z","steps":["trace[1695820414] 'agreement among raft nodes before linearized reading' (duration: 68.462145ms)","trace[1695820414] 'range keys from in-memory index tree' (duration: 132.191473ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:56:44.333558Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"132.531892ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:56:44.333861Z","caller":"traceutil/trace.go:172","msg":"trace[418216608] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"279.487793ms","start":"2026-04-17T00:56:44.054353Z","end":"2026-04-17T00:56:44.333840Z","steps":["trace[418216608] 'process raft request' (duration: 146.551271ms)","trace[418216608] 'compare' (duration: 132.199744ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:56:44.333874Z","caller":"traceutil/trace.go:172","msg":"trace[97221920] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"204.388172ms","start":"2026-04-17T00:56:44.129462Z","end":"2026-04-17T00:56:44.333851Z","steps":["trace[97221920] 'process raft request' (duration: 204.234268ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:44.629267Z","caller":"traceutil/trace.go:172","msg":"trace[770624432] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"289.888302ms","start":"2026-04-17T00:56:44.339349Z","end":"2026-04-17T00:56:44.629237Z","steps":["trace[770624432] 'process raft request' (duration: 266.975391ms)","trace[770624432] 'compare' (duration: 22.600483ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:56:48.173958Z","caller":"traceutil/trace.go:172","msg":"trace[1243005640] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"110.421468ms","start":"2026-04-17T00:56:48.063515Z","end":"2026-04-17T00:56:48.173936Z","steps":["trace[1243005640] 'process raft request' (duration: 110.289504ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:48.477999Z","caller":"traceutil/trace.go:172","msg":"trace[1433246303] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"132.391149ms","start":"2026-04-17T00:56:48.345588Z","end":"2026-04-17T00:56:48.477979Z","steps":["trace[1433246303] 'process raft request' (duration: 132.342467ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:48.478354Z","caller":"traceutil/trace.go:172","msg":"trace[35822268] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"132.914652ms","start":"2026-04-17T00:56:48.345413Z","end":"2026-04-17T00:56:48.478328Z","steps":["trace[35822268] 'process raft request' (duration: 132.403499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:56:52.842869Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.488261ms","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-17T00:56:52.842952Z","caller":"traceutil/trace.go:172","msg":"trace[1227595060] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:988; }","duration":"116.586323ms","start":"2026-04-17T00:56:52.726349Z","end":"2026-04-17T00:56:52.842935Z","steps":["trace[1227595060] 'range keys from in-memory index tree' (duration: 116.305096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:56:52.843296Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"179.560522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:56:52.843346Z","caller":"traceutil/trace.go:172","msg":"trace[1559489086] range","detail":"{range_begin:/registry/services/endpoints; range_end:; response_count:0; response_revision:988; }","duration":"179.610544ms","start":"2026-04-17T00:56:52.663723Z","end":"2026-04-17T00:56:52.843333Z","steps":["trace[1559489086] 'range keys from in-memory index tree' (duration: 179.508961ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:54.381301Z","caller":"traceutil/trace.go:172","msg":"trace[435801593] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"147.624599ms","start":"2026-04-17T00:56:54.233652Z","end":"2026-04-17T00:56:54.381277Z","steps":["trace[435801593] 'process raft request' (duration: 147.439674ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:54.737982Z","caller":"traceutil/trace.go:172","msg":"trace[1953266347] linearizableReadLoop","detail":"{readStateIndex:1038; appliedIndex:1038; }","duration":"113.640657ms","start":"2026-04-17T00:56:54.624310Z","end":"2026-04-17T00:56:54.737951Z","steps":["trace[1953266347] 'read index received' (duration: 113.620917ms)","trace[1953266347] 'applied index is now lower than readState.Index' (duration: 17.82µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:56:54.738222Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"113.865633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:56:54.738271Z","caller":"traceutil/trace.go:172","msg":"trace[671710591] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies; range_end:; response_count:0; response_revision:991; }","duration":"113.949696ms","start":"2026-04-17T00:56:54.624307Z","end":"2026-04-17T00:56:54.738256Z","steps":["trace[671710591] 'agreement among raft nodes before linearized reading' (duration: 113.811952ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:54.738331Z","caller":"traceutil/trace.go:172","msg":"trace[419811532] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"121.873064ms","start":"2026-04-17T00:56:54.616431Z","end":"2026-04-17T00:56:54.738304Z","steps":["trace[419811532] 'process raft request' (duration: 121.706679ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:56:55.214724Z","caller":"traceutil/trace.go:172","msg":"trace[685109660] linearizableReadLoop","detail":"{readStateIndex:1039; appliedIndex:1039; }","duration":"476.631667ms","start":"2026-04-17T00:56:54.738059Z","end":"2026-04-17T00:56:55.214691Z","steps":["trace[685109660] 'read index received' (duration: 476.619006ms)","trace[685109660] 'applied index is now lower than readState.Index' (duration: 11.031µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:56:55.216089Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"560.96616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:56:55.216705Z","caller":"traceutil/trace.go:172","msg":"trace[234083567] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes; range_end:; response_count:0; response_revision:992; }","duration":"561.335731ms","start":"2026-04-17T00:56:54.655055Z","end":"2026-04-17T00:56:55.216390Z","steps":["trace[234083567] 'agreement among raft nodes before linearized reading' (duration: 559.731725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:56:55.216903Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"172.103332ms","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-17T00:56:55.216990Z","caller":"traceutil/trace.go:172","msg":"trace[1140849805] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:992; }","duration":"172.202394ms","start":"2026-04-17T00:56:55.044768Z","end":"2026-04-17T00:56:55.216970Z","steps":["trace[1140849805] 'range keys from in-memory index tree' (duration: 172.04963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:56:55.217363Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"561.177127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T00:56:55.217386Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:56:54.655024Z","time spent":"561.861365ms","remote":"127.0.0.1:36738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodes\" limit:1 "} {"level":"info","ts":"2026-04-17T00:56:55.217444Z","caller":"traceutil/trace.go:172","msg":"trace[1564736712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:992; }","duration":"561.265339ms","start":"2026-04-17T00:56:54.656162Z","end":"2026-04-17T00:56:55.217427Z","steps":["trace[1564736712] 'agreement among raft nodes before linearized reading' (duration: 558.602576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:56:55.217487Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:56:54.656146Z","time spent":"561.332751ms","remote":"127.0.0.1:59240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T00:56:55.217707Z","caller":"traceutil/trace.go:172","msg":"trace[598643442] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"594.924742ms","start":"2026-04-17T00:56:54.622762Z","end":"2026-04-17T00:56:55.217687Z","steps":["trace[598643442] 'process raft request' (duration: 591.990801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:56:55.217820Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:56:54.622749Z","time spent":"595.008404ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:56:55.218169Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"301.821112ms","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-17T00:56:55.218216Z","caller":"traceutil/trace.go:172","msg":"trace[1110746336] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:993; }","duration":"301.871793ms","start":"2026-04-17T00:56:54.916332Z","end":"2026-04-17T00:56:55.218204Z","steps":["trace[1110746336] 'agreement among raft nodes before linearized reading' (duration: 301.695799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:56:55.218249Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:56:54.916303Z","time spent":"301.936854ms","remote":"127.0.0.1:59658","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":"info","ts":"2026-04-17T00:56:57.699745Z","caller":"traceutil/trace.go:172","msg":"trace[263102386] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"416.202093ms","start":"2026-04-17T00:56:57.283504Z","end":"2026-04-17T00:56:57.699706Z","steps":["trace[263102386] 'process raft request' (duration: 352.317766ms)","trace[263102386] 'compare' (duration: 63.783154ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:56:57.699829Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:56:57.283487Z","time spent":"416.301766ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":479,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:56:57.808146Z","caller":"traceutil/trace.go:172","msg":"trace[758258773] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1045; }","duration":"150.209285ms","start":"2026-04-17T00:56:57.657912Z","end":"2026-04-17T00:56:57.808122Z","steps":["trace[758258773] 'read index received' (duration: 150.202135ms)","trace[758258773] 'applied index is now lower than readState.Index' (duration: 6.21µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:56:57.831856Z","caller":"traceutil/trace.go:172","msg":"trace[550830789] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"376.168347ms","start":"2026-04-17T00:56:57.455670Z","end":"2026-04-17T00:56:57.831838Z","steps":["trace[550830789] 'process raft request' (duration: 352.501323ms)","trace[550830789] 'compare' (duration: 23.577002ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:56:57.832083Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-17T00:56:57.455611Z","time spent":"376.296832ms","remote":"127.0.0.1:59658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:56:57.832226Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"173.87698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:56:57.832373Z","caller":"traceutil/trace.go:172","msg":"trace[489102251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"174.450656ms","start":"2026-04-17T00:56:57.657907Z","end":"2026-04-17T00:56:57.832358Z","steps":["trace[489102251] 'agreement among raft nodes before linearized reading' (duration: 150.294008ms)","trace[489102251] 'range keys from in-memory index tree' (duration: 23.49909ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:56:58.153536Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"108.852046ms","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-17T00:56:58.153587Z","caller":"traceutil/trace.go:172","msg":"trace[64959935] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:999; }","duration":"108.936957ms","start":"2026-04-17T00:56:58.044641Z","end":"2026-04-17T00:56:58.153578Z","steps":["trace[64959935] 'range keys from in-memory index tree' (duration: 108.791743ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:57:10.968606Z","caller":"traceutil/trace.go:172","msg":"trace[223407114] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"153.23783ms","start":"2026-04-17T00:57:10.815343Z","end":"2026-04-17T00:57:10.968581Z","steps":["trace[223407114] 'process raft request' (duration: 153.054815ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:57:12.041626Z","caller":"traceutil/trace.go:172","msg":"trace[517983896] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"264.063599ms","start":"2026-04-17T00:57:11.777542Z","end":"2026-04-17T00:57:12.041606Z","steps":["trace[517983896] 'process raft request' (duration: 263.905664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:57:12.783980Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"126.603747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:57:12.784068Z","caller":"traceutil/trace.go:172","msg":"trace[148954575] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1032; }","duration":"127.429483ms","start":"2026-04-17T00:57:12.656621Z","end":"2026-04-17T00:57:12.784051Z","steps":["trace[148954575] 'range keys from in-memory index tree' (duration: 126.533833ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:57:55.936135Z","caller":"traceutil/trace.go:172","msg":"trace[233719351] linearizableReadLoop","detail":"{readStateIndex:1189; appliedIndex:1189; }","duration":"295.901261ms","start":"2026-04-17T00:57:55.640188Z","end":"2026-04-17T00:57:55.936089Z","steps":["trace[233719351] 'read index received' (duration: 295.88329ms)","trace[233719351] 'applied index is now lower than readState.Index' (duration: 16.271µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:57:55.936362Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"278.746674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:57:55.936336Z","caller":"traceutil/trace.go:172","msg":"trace[1878277129] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"299.088198ms","start":"2026-04-17T00:57:55.637218Z","end":"2026-04-17T00:57:55.936306Z","steps":["trace[1878277129] 'process raft request' (duration: 298.901401ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:57:55.936404Z","caller":"traceutil/trace.go:172","msg":"trace[1597512479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1131; }","duration":"278.803536ms","start":"2026-04-17T00:57:55.657591Z","end":"2026-04-17T00:57:55.936395Z","steps":["trace[1597512479] 'agreement among raft nodes before linearized reading' (duration: 278.709113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:57:55.936410Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"296.210443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" limit:1 ","response":"range_response_count:1 size:199"} {"level":"info","ts":"2026-04-17T00:57:55.936491Z","caller":"traceutil/trace.go:172","msg":"trace[1114035009] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:1; response_revision:1130; }","duration":"296.304686ms","start":"2026-04-17T00:57:55.640173Z","end":"2026-04-17T00:57:55.936477Z","steps":["trace[1114035009] 'agreement among raft nodes before linearized reading' (duration: 296.005755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:57:55.936603Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"273.843155ms","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-17T00:57:55.936683Z","caller":"traceutil/trace.go:172","msg":"trace[943494319] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:1131; }","duration":"273.934288ms","start":"2026-04-17T00:57:55.662730Z","end":"2026-04-17T00:57:55.936664Z","steps":["trace[943494319] 'agreement among raft nodes before linearized reading' (duration: 273.694029ms)"],"step_count":1}