{"level":"warn","ts":"2026-04-15T17:54:11.403537Z","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-15T17:54:11.403683Z","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-15T17:54:11.403713Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.233:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.19.213.233:2380","--initial-cluster=controller=https://199.19.213.233:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.233:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.233: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-15T17:54:11.403811Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-04-15T17:54:11.403842Z","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-15T17:54:11.403861Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.233:2380"]} {"level":"info","ts":"2026-04-15T17:54:11.403879Z","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-15T17:54:11.404632Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.233:2379"]} {"level":"info","ts":"2026-04-15T17:54:11.405367Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.233:2380"],"listen-peer-urls":["https://199.19.213.233:2380"],"advertise-client-urls":["https://199.19.213.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.19.213.233: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-15T17:54:11.406463Z","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: 0xc000078450}"} {"level":"info","ts":"2026-04-15T17:54:11.415695Z","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-15T17:54:11.415785Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.46723ms"} {"level":"info","ts":"2026-04-15T17:54:11.415823Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-04-15T17:54:11.415850Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-04-15T17:54:11.415899Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-04-15T17:54:11.436714Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-04-15T17:54:11.438443Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"de5c2ed1f829ccc5","cluster-id":"1c2360c7fdb72bdb"} {"level":"info","ts":"2026-04-15T17:54:11.438942Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-04-15T17:54:11.439119Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"de5c2ed1f829ccc5 switched to configuration voters=()"} {"level":"info","ts":"2026-04-15T17:54:11.439268Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"de5c2ed1f829ccc5 became follower at term 0"} {"level":"info","ts":"2026-04-15T17:54:11.439314Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft de5c2ed1f829ccc5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-15T17:54:11.439384Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"de5c2ed1f829ccc5 became follower at term 1"} {"level":"info","ts":"2026-04-15T17:54:11.439596Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"de5c2ed1f829ccc5 switched to configuration voters=(16022733053623913669)"} {"level":"warn","ts":"2026-04-15T17:54:11.451666Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-15T17:54:11.455438Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-15T17:54:11.462096Z","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-15T17:54:11.462812Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"de5c2ed1f829ccc5","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-15T17:54:11.463155Z","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-15T17:54:11.463699Z","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-15T17:54:11.463741Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.19.213.233:2380"} {"level":"info","ts":"2026-04-15T17:54:11.464066Z","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-15T17:54:11.464134Z","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-15T17:54:11.464485Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"de5c2ed1f829ccc5 switched to configuration voters=(16022733053623913669)"} {"level":"info","ts":"2026-04-15T17:54:11.464577Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.19.213.233:2380"} {"level":"info","ts":"2026-04-15T17:54:11.464511Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"de5c2ed1f829ccc5","initial-advertise-peer-urls":["https://199.19.213.233:2380"],"listen-peer-urls":["https://199.19.213.233:2380"],"advertise-client-urls":["https://199.19.213.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-15T17:54:11.464600Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-15T17:54:11.464714Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"1c2360c7fdb72bdb","local-member-id":"de5c2ed1f829ccc5","added-peer-id":"de5c2ed1f829ccc5","added-peer-peer-urls":["https://199.19.213.233:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-04-15T17:54:11.463376Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"de5c2ed1f829ccc5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-15T17:54:12.340301Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"de5c2ed1f829ccc5 is starting a new election at term 1"} {"level":"info","ts":"2026-04-15T17:54:12.340362Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"de5c2ed1f829ccc5 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-15T17:54:12.340432Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"de5c2ed1f829ccc5 received MsgPreVoteResp from de5c2ed1f829ccc5 at term 1"} {"level":"info","ts":"2026-04-15T17:54:12.340477Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"de5c2ed1f829ccc5 has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-15T17:54:12.340497Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"de5c2ed1f829ccc5 became candidate at term 2"} {"level":"info","ts":"2026-04-15T17:54:12.377123Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"de5c2ed1f829ccc5 received MsgVoteResp from de5c2ed1f829ccc5 at term 2"} {"level":"info","ts":"2026-04-15T17:54:12.377204Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"de5c2ed1f829ccc5 has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-15T17:54:12.377230Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"de5c2ed1f829ccc5 became leader at term 2"} {"level":"info","ts":"2026-04-15T17:54:12.377239Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: de5c2ed1f829ccc5 elected leader de5c2ed1f829ccc5 at term 2"} {"level":"info","ts":"2026-04-15T17:54:12.406047Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-04-15T17:54:12.440565Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"de5c2ed1f829ccc5","local-member-attributes":"{Name:controller ClientURLs:[https://199.19.213.233:2379]}","cluster-id":"1c2360c7fdb72bdb","publish-timeout":"7s"} {"level":"info","ts":"2026-04-15T17:54:12.440572Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T17:54:12.440611Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T17:54:12.440944Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-15T17:54:12.441002Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-04-15T17:54:12.442193Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-04-15T17:54:12.442391Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-15T17:54:12.442266Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-15T17:54:12.447377Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.233:2379"} {"level":"info","ts":"2026-04-15T17:54:12.448856Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-15T17:54:12.449162Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34124","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.449253Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34176","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.449345Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34136","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.460244Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34218","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-15T17:54:12.462022Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"1c2360c7fdb72bdb","local-member-id":"de5c2ed1f829ccc5","cluster-version":"3.6"} {"level":"info","ts":"2026-04-15T17:54:12.462251Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-04-15T17:54:12.462313Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-04-15T17:54:12.462426Z","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-15T17:54:12.462490Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"warn","ts":"2026-04-15T17:54:12.498398Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34254","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.509634Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34278","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.529320Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34312","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.539072Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34322","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.548704Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34356","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.562971Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34360","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.568795Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34376","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.577619Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34390","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.589712Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34416","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.600472Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34422","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.612687Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34434","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.628408Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34446","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.637760Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34468","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.652789Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34490","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.664498Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34500","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.760678Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34522","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.772757Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34536","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.789100Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34546","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.799738Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34558","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.814270Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34582","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.824062Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34614","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.843014Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34620","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.850654Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34640","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.860544Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34656","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.872747Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34682","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.882628Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34706","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.891446Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34734","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.902950Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34756","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.912624Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34762","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.921049Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34784","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.934318Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34804","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.949276Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34822","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.961109Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34836","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.971568Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34862","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.980115Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:12.997900Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34896","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.013370Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34922","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.017421Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34940","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.053608Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34976","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.065813Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34982","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.085506Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34996","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.096671Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35020","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.107690Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35038","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.115924Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35056","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.127672Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35066","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.138450Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35078","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.146562Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35098","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.156241Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35122","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.165740Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35140","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.176724Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35164","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.216984Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35184","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.224046Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35202","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.233394Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35220","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.301520Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35250","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:54:13.975259Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"126.389586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:13.975363Z","caller":"traceutil/trace.go:172","msg":"trace[1659816252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3; }","duration":"126.507727ms","start":"2026-04-15T17:54:13.848839Z","end":"2026-04-15T17:54:13.975347Z","steps":["trace[1659816252] 'agreement among raft nodes before linearized reading' (duration: 118.491956ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:13.975587Z","caller":"traceutil/trace.go:172","msg":"trace[793808966] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"127.899435ms","start":"2026-04-15T17:54:13.847674Z","end":"2026-04-15T17:54:13.975574Z","steps":["trace[793808966] 'process raft request' (duration: 119.735042ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:13.975741Z","caller":"traceutil/trace.go:172","msg":"trace[1297538251] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"119.336417ms","start":"2026-04-15T17:54:13.856379Z","end":"2026-04-15T17:54:13.975715Z","steps":["trace[1297538251] 'process raft request' (duration: 119.306146ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:13.976003Z","caller":"traceutil/trace.go:172","msg":"trace[926425005] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"127.660882ms","start":"2026-04-15T17:54:13.848331Z","end":"2026-04-15T17:54:13.975992Z","steps":["trace[926425005] 'process raft request' (duration: 127.182536ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:13.976037Z","caller":"traceutil/trace.go:172","msg":"trace[1259887830] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"126.879772ms","start":"2026-04-15T17:54:13.849146Z","end":"2026-04-15T17:54:13.976026Z","steps":["trace[1259887830] 'process raft request' (duration: 126.475837ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:13.976115Z","caller":"traceutil/trace.go:172","msg":"trace[783156960] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"127.628482ms","start":"2026-04-15T17:54:13.848477Z","end":"2026-04-15T17:54:13.976106Z","steps":["trace[783156960] 'process raft request' (duration: 127.069045ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:13.976150Z","caller":"traceutil/trace.go:172","msg":"trace[1991991309] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"126.158133ms","start":"2026-04-15T17:54:13.849982Z","end":"2026-04-15T17:54:13.976140Z","steps":["trace[1991991309] 'process raft request' (duration: 125.660707ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:13.976221Z","caller":"traceutil/trace.go:172","msg":"trace[1852147906] transaction","detail":"{read_only:false; number_of_response:0; response_revision:10; }","duration":"125.985441ms","start":"2026-04-15T17:54:13.850228Z","end":"2026-04-15T17:54:13.976214Z","steps":["trace[1852147906] 'process raft request' (duration: 125.438034ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:13.976263Z","caller":"traceutil/trace.go:172","msg":"trace[54985783] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"127.703482ms","start":"2026-04-15T17:54:13.848546Z","end":"2026-04-15T17:54:13.976250Z","steps":["trace[54985783] 'process raft request' (duration: 127.026064ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:13.976699Z","caller":"traceutil/trace.go:172","msg":"trace[1487110475] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"128.079857ms","start":"2026-04-15T17:54:13.848607Z","end":"2026-04-15T17:54:13.976687Z","steps":["trace[1487110475] 'process raft request' (duration: 126.989673ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.114791Z","caller":"traceutil/trace.go:172","msg":"trace[1622364686] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:15; }","duration":"147.451887ms","start":"2026-04-15T17:54:13.967308Z","end":"2026-04-15T17:54:14.114760Z","steps":["trace[1622364686] 'read index received' (duration: 147.439707ms)","trace[1622364686] 'applied index is now lower than readState.Index' (duration: 10.33µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:14.134586Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"199.632054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/controller\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-15T17:54:14.134711Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"226.925379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:14.134828Z","caller":"traceutil/trace.go:172","msg":"trace[316378019] range","detail":"{range_begin:/registry/csinodes/controller; range_end:; response_count:0; response_revision:11; }","duration":"199.717665ms","start":"2026-04-15T17:54:13.934922Z","end":"2026-04-15T17:54:14.134640Z","steps":["trace[316378019] 'agreement among raft nodes before linearized reading' (duration: 180.009807ms)","trace[316378019] 'range keys from in-memory index tree' (duration: 19.582927ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:14.134769Z","caller":"traceutil/trace.go:172","msg":"trace[1354160115] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"226.97871ms","start":"2026-04-15T17:54:13.907779Z","end":"2026-04-15T17:54:14.134758Z","steps":["trace[1354160115] 'agreement among raft nodes before linearized reading' (duration: 207.070359ms)","trace[1354160115] 'range keys from in-memory index tree' (duration: 19.807039ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:14.134988Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"236.190226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-15T17:54:14.135089Z","caller":"traceutil/trace.go:172","msg":"trace[1709273998] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:11; }","duration":"236.308548ms","start":"2026-04-15T17:54:13.898760Z","end":"2026-04-15T17:54:14.135068Z","steps":["trace[1709273998] 'agreement among raft nodes before linearized reading' (duration: 216.138734ms)","trace[1709273998] 'range keys from in-memory index tree' (duration: 19.89333ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:14.135332Z","caller":"traceutil/trace.go:172","msg":"trace[1783464351] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"252.246219ms","start":"2026-04-15T17:54:13.882770Z","end":"2026-04-15T17:54:14.135017Z","steps":["trace[1783464351] 'process raft request' (duration: 232.128976ms)","trace[1783464351] 'compare' (duration: 19.819849ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:14.141731Z","caller":"traceutil/trace.go:172","msg":"trace[1904579087] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"160.150286ms","start":"2026-04-15T17:54:13.981555Z","end":"2026-04-15T17:54:14.141705Z","steps":["trace[1904579087] 'process raft request' (duration: 160.020124ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.141727Z","caller":"traceutil/trace.go:172","msg":"trace[564081945] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"162.294412ms","start":"2026-04-15T17:54:13.979344Z","end":"2026-04-15T17:54:14.141638Z","steps":["trace[564081945] 'process raft request' (duration: 161.963668ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.141798Z","caller":"traceutil/trace.go:172","msg":"trace[70129751] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"160.047294ms","start":"2026-04-15T17:54:13.981744Z","end":"2026-04-15T17:54:14.141791Z","steps":["trace[70129751] 'process raft request' (duration: 159.882832ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.141870Z","caller":"traceutil/trace.go:172","msg":"trace[945271678] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"159.498397ms","start":"2026-04-15T17:54:13.982365Z","end":"2026-04-15T17:54:14.141863Z","steps":["trace[945271678] 'process raft request' (duration: 159.279564ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.141766Z","caller":"traceutil/trace.go:172","msg":"trace[1836372862] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"152.458499ms","start":"2026-04-15T17:54:13.989297Z","end":"2026-04-15T17:54:14.141756Z","steps":["trace[1836372862] 'process raft request' (duration: 152.429558ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.142105Z","caller":"traceutil/trace.go:172","msg":"trace[1576471098] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"157.110557ms","start":"2026-04-15T17:54:13.984987Z","end":"2026-04-15T17:54:14.142098Z","steps":["trace[1576471098] 'process raft request' (duration: 156.678181ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.142146Z","caller":"traceutil/trace.go:172","msg":"trace[523543496] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"160.691003ms","start":"2026-04-15T17:54:13.981237Z","end":"2026-04-15T17:54:14.141928Z","steps":["trace[523543496] 'process raft request' (duration: 160.258857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:14.142297Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"164.937866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:14.142345Z","caller":"traceutil/trace.go:172","msg":"trace[2046424608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"165.006367ms","start":"2026-04-15T17:54:13.977327Z","end":"2026-04-15T17:54:14.142334Z","steps":["trace[2046424608] 'agreement among raft nodes before linearized reading' (duration: 164.840675ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.142421Z","caller":"traceutil/trace.go:172","msg":"trace[1567709095] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"155.253183ms","start":"2026-04-15T17:54:13.987118Z","end":"2026-04-15T17:54:14.142371Z","steps":["trace[1567709095] 'process raft request' (duration: 154.565885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:14.142414Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"125.54274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:14.142474Z","caller":"traceutil/trace.go:172","msg":"trace[1707784388] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:20; }","duration":"125.61401ms","start":"2026-04-15T17:54:14.016845Z","end":"2026-04-15T17:54:14.142459Z","steps":["trace[1707784388] 'agreement among raft nodes before linearized reading' (duration: 125.515189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:14.142544Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"164.840414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-15T17:54:14.142571Z","caller":"traceutil/trace.go:172","msg":"trace[1441243317] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"164.877855ms","start":"2026-04-15T17:54:13.977686Z","end":"2026-04-15T17:54:14.142564Z","steps":["trace[1441243317] 'agreement among raft nodes before linearized reading' (duration: 164.768803ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.310955Z","caller":"traceutil/trace.go:172","msg":"trace[1179679288] linearizableReadLoop","detail":"{readStateIndex:25; appliedIndex:25; }","duration":"119.477612ms","start":"2026-04-15T17:54:14.191444Z","end":"2026-04-15T17:54:14.310922Z","steps":["trace[1179679288] 'read index received' (duration: 119.469672ms)","trace[1179679288] 'applied index is now lower than readState.Index' (duration: 6.51µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:14.312252Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"163.914722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:14.312296Z","caller":"traceutil/trace.go:172","msg":"trace[1850030422] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:21; }","duration":"163.979103ms","start":"2026-04-15T17:54:14.148306Z","end":"2026-04-15T17:54:14.312286Z","steps":["trace[1850030422] 'agreement among raft nodes before linearized reading' (duration: 162.744477ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.312500Z","caller":"traceutil/trace.go:172","msg":"trace[410599823] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"170.822089ms","start":"2026-04-15T17:54:14.141649Z","end":"2026-04-15T17:54:14.312471Z","steps":["trace[410599823] 'process raft request' (duration: 169.368031ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.312676Z","caller":"traceutil/trace.go:172","msg":"trace[1443358942] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"165.489511ms","start":"2026-04-15T17:54:14.147176Z","end":"2026-04-15T17:54:14.312665Z","steps":["trace[1443358942] 'process raft request' (duration: 165.226398ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.312926Z","caller":"traceutil/trace.go:172","msg":"trace[852303578] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"165.242339ms","start":"2026-04-15T17:54:14.147675Z","end":"2026-04-15T17:54:14.312917Z","steps":["trace[852303578] 'process raft request' (duration: 164.767053ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.313038Z","caller":"traceutil/trace.go:172","msg":"trace[1700355680] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"164.955125ms","start":"2026-04-15T17:54:14.148069Z","end":"2026-04-15T17:54:14.313024Z","steps":["trace[1700355680] 'process raft request' (duration: 164.5896ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.313132Z","caller":"traceutil/trace.go:172","msg":"trace[774088357] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"164.663301ms","start":"2026-04-15T17:54:14.148461Z","end":"2026-04-15T17:54:14.313125Z","steps":["trace[774088357] 'process raft request' (duration: 164.56037ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.313174Z","caller":"traceutil/trace.go:172","msg":"trace[1748245841] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"160.761852ms","start":"2026-04-15T17:54:14.152406Z","end":"2026-04-15T17:54:14.313168Z","steps":["trace[1748245841] 'process raft request' (duration: 160.664681ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.313213Z","caller":"traceutil/trace.go:172","msg":"trace[52387189] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"160.64138ms","start":"2026-04-15T17:54:14.152565Z","end":"2026-04-15T17:54:14.313206Z","steps":["trace[52387189] 'process raft request' (duration: 160.542549ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.313270Z","caller":"traceutil/trace.go:172","msg":"trace[1773655175] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"160.61949ms","start":"2026-04-15T17:54:14.152644Z","end":"2026-04-15T17:54:14.313264Z","steps":["trace[1773655175] 'process raft request' (duration: 160.494998ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.313324Z","caller":"traceutil/trace.go:172","msg":"trace[1111630881] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"116.962941ms","start":"2026-04-15T17:54:14.196329Z","end":"2026-04-15T17:54:14.313292Z","steps":["trace[1111630881] 'process raft request' (duration: 116.898791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:14.313660Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"120.724029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" limit:1 ","response":"range_response_count:1 size:338"} {"level":"info","ts":"2026-04-15T17:54:14.314015Z","caller":"traceutil/trace.go:172","msg":"trace[1987436890] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:1; response_revision:31; }","duration":"121.096223ms","start":"2026-04-15T17:54:14.192912Z","end":"2026-04-15T17:54:14.314008Z","steps":["trace[1987436890] 'agreement among raft nodes before linearized reading' (duration: 120.683448ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.313438Z","caller":"traceutil/trace.go:172","msg":"trace[1678406028] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"157.485891ms","start":"2026-04-15T17:54:14.155944Z","end":"2026-04-15T17:54:14.313430Z","steps":["trace[1678406028] 'process raft request' (duration: 157.237318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:14.852303Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"108.186371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:14.852395Z","caller":"traceutil/trace.go:172","msg":"trace[30072124] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:31; }","duration":"108.284952ms","start":"2026-04-15T17:54:14.744087Z","end":"2026-04-15T17:54:14.852372Z","steps":["trace[30072124] 'agreement among raft nodes before linearized reading' (duration: 21.695873ms)","trace[30072124] 'range keys from in-memory index tree' (duration: 86.457658ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:14.852389Z","caller":"traceutil/trace.go:172","msg":"trace[1023288143] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"535.331384ms","start":"2026-04-15T17:54:14.317019Z","end":"2026-04-15T17:54:14.852350Z","steps":["trace[1023288143] 'process raft request' (duration: 448.828296ms)","trace[1023288143] 'compare' (duration: 86.362146ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:14.853745Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.316997Z","time spent":"535.481066ms","remote":"127.0.0.1:34336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:14.866121Z","caller":"traceutil/trace.go:172","msg":"trace[229270063] linearizableReadLoop","detail":"{readStateIndex:36; appliedIndex:36; }","duration":"100.340972ms","start":"2026-04-15T17:54:14.765761Z","end":"2026-04-15T17:54:14.866102Z","steps":["trace[229270063] 'read index received' (duration: 100.333762ms)","trace[229270063] 'applied index is now lower than readState.Index' (duration: 5.87µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:14.866320Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"121.385328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:14.866360Z","caller":"traceutil/trace.go:172","msg":"trace[1302468703] range","detail":"{range_begin:/registry/clusterroles; range_end:; response_count:0; response_revision:32; }","duration":"121.433918ms","start":"2026-04-15T17:54:14.744915Z","end":"2026-04-15T17:54:14.866349Z","steps":["trace[1302468703] 'agreement among raft nodes before linearized reading' (duration: 121.358407ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.866461Z","caller":"traceutil/trace.go:172","msg":"trace[229753164] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"548.634691ms","start":"2026-04-15T17:54:14.317813Z","end":"2026-04-15T17:54:14.866447Z","steps":["trace[229753164] 'process raft request' (duration: 548.50403ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.866455Z","caller":"traceutil/trace.go:172","msg":"trace[1219439102] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"548.761863ms","start":"2026-04-15T17:54:14.317662Z","end":"2026-04-15T17:54:14.866423Z","steps":["trace[1219439102] 'process raft request' (duration: 548.593561ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.866510Z","caller":"traceutil/trace.go:172","msg":"trace[1729584383] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"547.961363ms","start":"2026-04-15T17:54:14.318496Z","end":"2026-04-15T17:54:14.866458Z","steps":["trace[1729584383] 'process raft request' (duration: 547.863821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:14.866546Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.317803Z","time spent":"548.691522ms","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:14.866587Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.318424Z","time spent":"548.119035ms","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":953,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:14.866539Z","caller":"traceutil/trace.go:172","msg":"trace[1541318481] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"546.96181ms","start":"2026-04-15T17:54:14.319562Z","end":"2026-04-15T17:54:14.866523Z","steps":["trace[1541318481] 'process raft request' (duration: 546.93041ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.866658Z","caller":"traceutil/trace.go:172","msg":"trace[685898942] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"548.051774ms","start":"2026-04-15T17:54:14.318596Z","end":"2026-04-15T17:54:14.866648Z","steps":["trace[685898942] 'process raft request' (duration: 547.804281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:14.866665Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.319554Z","time spent":"547.096612ms","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:14.866688Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.317645Z","time spent":"548.883834ms","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:14.866701Z","caller":"traceutil/trace.go:172","msg":"trace[1907886428] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"547.841752ms","start":"2026-04-15T17:54:14.318847Z","end":"2026-04-15T17:54:14.866689Z","steps":["trace[1907886428] 'process raft request' (duration: 547.591818ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:14.866713Z","caller":"traceutil/trace.go:172","msg":"trace[733296068] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"547.193904ms","start":"2026-04-15T17:54:14.319512Z","end":"2026-04-15T17:54:14.866706Z","steps":["trace[733296068] 'process raft request' (duration: 546.953921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:14.866716Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.318587Z","time spent":"548.099354ms","remote":"127.0.0.1:34968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":703,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:14.866743Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.319501Z","time spent":"547.228754ms","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:14.866763Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.318833Z","time spent":"547.895292ms","remote":"127.0.0.1:34346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":350,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:14.867008Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.317251Z","time spent":"549.717045ms","remote":"127.0.0.1:34288","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-15T17:54:14.972618Z","caller":"traceutil/trace.go:172","msg":"trace[225879077] linearizableReadLoop","detail":"{readStateIndex:46; appliedIndex:46; }","duration":"100.597976ms","start":"2026-04-15T17:54:14.871934Z","end":"2026-04-15T17:54:14.972532Z","steps":["trace[225879077] 'read index received' (duration: 100.587256ms)","trace[225879077] 'applied index is now lower than readState.Index' (duration: 8.97µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:15.222394Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"350.347798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-cluster-critical\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:15.222542Z","caller":"traceutil/trace.go:172","msg":"trace[1232927934] range","detail":"{range_begin:/registry/priorityclasses/system-cluster-critical; range_end:; response_count:0; response_revision:41; }","duration":"350.588131ms","start":"2026-04-15T17:54:14.871929Z","end":"2026-04-15T17:54:15.222517Z","steps":["trace[1232927934] 'agreement among raft nodes before linearized reading' (duration: 100.726827ms)","trace[1232927934] 'range keys from in-memory index tree' (duration: 249.55889ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:15.222608Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.871915Z","time spent":"350.679102ms","remote":"127.0.0.1:34824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-cluster-critical\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:15.222937Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"249.940424ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-15T17:54:15.223181Z","caller":"traceutil/trace.go:172","msg":"trace[502787566] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"351.992248ms","start":"2026-04-15T17:54:14.871097Z","end":"2026-04-15T17:54:15.223090Z","steps":["trace[502787566] 'process raft request' (duration: 101.505797ms)","trace[502787566] 'compare' (duration: 249.489049ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:15.223324Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.871074Z","time spent":"352.17999ms","remote":"127.0.0.1:34288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":637,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:15.223382Z","caller":"traceutil/trace.go:172","msg":"trace[318352306] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"350.52108ms","start":"2026-04-15T17:54:14.872842Z","end":"2026-04-15T17:54:15.223363Z","steps":["trace[318352306] 'process raft request' (duration: 350.407548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:15.223452Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.872800Z","time spent":"350.621121ms","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:15.223568Z","caller":"traceutil/trace.go:172","msg":"trace[563263367] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"351.670744ms","start":"2026-04-15T17:54:14.871870Z","end":"2026-04-15T17:54:15.223541Z","steps":["trace[563263367] 'process raft request' (duration: 351.210898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:15.223706Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.871854Z","time spent":"351.795286ms","remote":"127.0.0.1:34968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":701,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:15.225596Z","caller":"traceutil/trace.go:172","msg":"trace[475601516] linearizableReadLoop","detail":"{readStateIndex:47; appliedIndex:46; }","duration":"252.746119ms","start":"2026-04-15T17:54:14.972829Z","end":"2026-04-15T17:54:15.225575Z","steps":["trace[475601516] 'read index received' (duration: 229.406267ms)","trace[475601516] 'applied index is now lower than readState.Index' (duration: 23.337132ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:15.225693Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"351.724305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:15.225746Z","caller":"traceutil/trace.go:172","msg":"trace[645114685] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:44; }","duration":"351.778435ms","start":"2026-04-15T17:54:14.873952Z","end":"2026-04-15T17:54:15.225731Z","steps":["trace[645114685] 'agreement among raft nodes before linearized reading' (duration: 351.674154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:15.225936Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.873942Z","time spent":"351.980108ms","remote":"127.0.0.1:34810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":33,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:15.226231Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"176.432791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:15.226447Z","caller":"traceutil/trace.go:172","msg":"trace[309033713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:44; }","duration":"176.655854ms","start":"2026-04-15T17:54:15.049776Z","end":"2026-04-15T17:54:15.226431Z","steps":["trace[309033713] 'agreement among raft nodes before linearized reading' (duration: 176.399851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:15.226853Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"354.258837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-15T17:54:15.227068Z","caller":"traceutil/trace.go:172","msg":"trace[444888103] range","detail":"{range_begin:/registry/certificatesigningrequests; range_end:; response_count:0; response_revision:44; }","duration":"354.48318ms","start":"2026-04-15T17:54:14.872571Z","end":"2026-04-15T17:54:15.227055Z","steps":["trace[444888103] 'agreement among raft nodes before linearized reading' (duration: 353.371626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:15.227825Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:14.872561Z","time spent":"355.240989ms","remote":"127.0.0.1:34572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":27,"request content":"key:\"/registry/certificatesigningrequests\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:15.467996Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"154.280583ms","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-15T17:54:15.468083Z","caller":"traceutil/trace.go:172","msg":"trace[46749784] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:0; response_revision:48; }","duration":"154.384634ms","start":"2026-04-15T17:54:15.313679Z","end":"2026-04-15T17:54:15.468064Z","steps":["trace[46749784] 'agreement among raft nodes before linearized reading' (duration: 68.210125ms)","trace[46749784] 'range keys from in-memory index tree' (duration: 86.020717ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:15.468238Z","caller":"traceutil/trace.go:172","msg":"trace[763821693] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"154.85718ms","start":"2026-04-15T17:54:15.313354Z","end":"2026-04-15T17:54:15.468212Z","steps":["trace[763821693] 'process raft request' (duration: 154.796759ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:15.468467Z","caller":"traceutil/trace.go:172","msg":"trace[1573456672] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"165.157409ms","start":"2026-04-15T17:54:15.303296Z","end":"2026-04-15T17:54:15.468454Z","steps":["trace[1573456672] 'process raft request' (duration: 78.666336ms)","trace[1573456672] 'compare' (duration: 85.892885ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:18.244413Z","caller":"traceutil/trace.go:172","msg":"trace[1440874972] linearizableReadLoop","detail":"{readStateIndex:277; appliedIndex:277; }","duration":"101.382148ms","start":"2026-04-15T17:54:18.142977Z","end":"2026-04-15T17:54:18.244359Z","steps":["trace[1440874972] 'read index received' (duration: 101.372518ms)","trace[1440874972] 'applied index is now lower than readState.Index' (duration: 8.55µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:18.244573Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.57798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:18.244631Z","caller":"traceutil/trace.go:172","msg":"trace[1423277643] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:271; }","duration":"101.643241ms","start":"2026-04-15T17:54:18.142974Z","end":"2026-04-15T17:54:18.244617Z","steps":["trace[1423277643] 'agreement among raft nodes before linearized reading' (duration: 101.53491ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:18.244691Z","caller":"traceutil/trace.go:172","msg":"trace[751737551] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"103.98912ms","start":"2026-04-15T17:54:18.140675Z","end":"2026-04-15T17:54:18.244664Z","steps":["trace[751737551] 'process raft request' (duration: 103.805628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:18.245731Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"102.475901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T17:54:18.245759Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.885494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:18.245821Z","caller":"traceutil/trace.go:172","msg":"trace[1668323222] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:0; response_revision:272; }","duration":"102.583553ms","start":"2026-04-15T17:54:18.143218Z","end":"2026-04-15T17:54:18.245802Z","steps":["trace[1668323222] 'agreement among raft nodes before linearized reading' (duration: 102.4035ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:18.245832Z","caller":"traceutil/trace.go:172","msg":"trace[2053527795] range","detail":"{range_begin:/registry/serviceaccounts; range_end:; response_count:0; response_revision:272; }","duration":"101.973205ms","start":"2026-04-15T17:54:18.143845Z","end":"2026-04-15T17:54:18.245818Z","steps":["trace[2053527795] 'agreement among raft nodes before linearized reading' (duration: 101.830973ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:18.245788Z","caller":"traceutil/trace.go:172","msg":"trace[507791915] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"103.97215ms","start":"2026-04-15T17:54:18.141799Z","end":"2026-04-15T17:54:18.245771Z","steps":["trace[507791915] 'process raft request' (duration: 103.859249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:18.620078Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"270.989892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:18.620202Z","caller":"traceutil/trace.go:172","msg":"trace[757968473] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:0; response_revision:282; }","duration":"271.122653ms","start":"2026-04-15T17:54:18.349058Z","end":"2026-04-15T17:54:18.620181Z","steps":["trace[757968473] 'agreement among raft nodes before linearized reading' (duration: 90.690115ms)","trace[757968473] 'range keys from in-memory index tree' (duration: 180.269836ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:18.620828Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"180.998555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T17:54:18.621129Z","caller":"traceutil/trace.go:172","msg":"trace[1957722605] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"272.681593ms","start":"2026-04-15T17:54:18.348418Z","end":"2026-04-15T17:54:18.621100Z","steps":["trace[1957722605] 'process raft request' (duration: 91.347313ms)","trace[1957722605] 'compare' (duration: 180.308587ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:18.621812Z","caller":"traceutil/trace.go:172","msg":"trace[184074547] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"205.251416ms","start":"2026-04-15T17:54:18.416539Z","end":"2026-04-15T17:54:18.621791Z","steps":["trace[184074547] 'process raft request' (duration: 205.152435ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:18.621812Z","caller":"traceutil/trace.go:172","msg":"trace[1133544340] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:288; }","duration":"182.044608ms","start":"2026-04-15T17:54:18.439716Z","end":"2026-04-15T17:54:18.621760Z","steps":["trace[1133544340] 'read index received' (duration: 129.101471ms)","trace[1133544340] 'applied index is now lower than readState.Index' (duration: 52.938407ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:18.621906Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"199.218251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/controller\" limit:1 ","response":"range_response_count:1 size:700"} {"level":"info","ts":"2026-04-15T17:54:18.621948Z","caller":"traceutil/trace.go:172","msg":"trace[184303649] range","detail":"{range_begin:/registry/csinodes/controller; range_end:; response_count:1; response_revision:284; }","duration":"199.262992ms","start":"2026-04-15T17:54:18.422674Z","end":"2026-04-15T17:54:18.621937Z","steps":["trace[184303649] 'agreement among raft nodes before linearized reading' (duration: 199.12207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:18.622074Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"204.852182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:18.622114Z","caller":"traceutil/trace.go:172","msg":"trace[675192336] range","detail":"{range_begin:/registry/leases/kube-node-lease/controller; range_end:; response_count:0; response_revision:284; }","duration":"204.945193ms","start":"2026-04-15T17:54:18.417160Z","end":"2026-04-15T17:54:18.622105Z","steps":["trace[675192336] 'agreement among raft nodes before linearized reading' (duration: 204.784671ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:18.899304Z","caller":"traceutil/trace.go:172","msg":"trace[1190539586] linearizableReadLoop","detail":"{readStateIndex:290; appliedIndex:290; }","duration":"277.356701ms","start":"2026-04-15T17:54:18.621902Z","end":"2026-04-15T17:54:18.899258Z","steps":["trace[1190539586] 'read index received' (duration: 277.337101ms)","trace[1190539586] 'applied index is now lower than readState.Index' (duration: 17.2µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:19.189988Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"700.057336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:19.190055Z","caller":"traceutil/trace.go:172","msg":"trace[1008499102] range","detail":"{range_begin:/registry/resourceslices; range_end:; response_count:0; response_revision:284; }","duration":"700.142847ms","start":"2026-04-15T17:54:18.489897Z","end":"2026-04-15T17:54:19.190039Z","steps":["trace[1008499102] 'agreement among raft nodes before linearized reading' (duration: 409.500311ms)","trace[1008499102] 'range keys from in-memory index tree' (duration: 290.410534ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:19.190090Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.489878Z","time spent":"700.203818ms","remote":"127.0.0.1:35206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/resourceslices\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:19.190191Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"290.799438ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-04-15T17:54:19.190476Z","caller":"traceutil/trace.go:172","msg":"trace[1654798359] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"640.098372ms","start":"2026-04-15T17:54:18.550317Z","end":"2026-04-15T17:54:19.190416Z","steps":["trace[1654798359] 'process raft request' (duration: 348.99797ms)","trace[1654798359] 'compare' (duration: 290.742218ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:19.190529Z","caller":"traceutil/trace.go:172","msg":"trace[1376778815] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"639.9121ms","start":"2026-04-15T17:54:18.550574Z","end":"2026-04-15T17:54:19.190486Z","steps":["trace[1376778815] 'process raft request' (duration: 639.733748ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:19.190607Z","caller":"traceutil/trace.go:172","msg":"trace[1150443723] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"639.490545ms","start":"2026-04-15T17:54:18.551102Z","end":"2026-04-15T17:54:19.190593Z","steps":["trace[1150443723] 'process raft request' (duration: 639.332693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:19.190655Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.550567Z","time spent":"640.026141ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5675,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:19.190680Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.551080Z","time spent":"639.560896ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3308,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:19.190677Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.550296Z","time spent":"640.290605ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:19.190706Z","caller":"traceutil/trace.go:172","msg":"trace[639500191] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"560.16199ms","start":"2026-04-15T17:54:18.630520Z","end":"2026-04-15T17:54:19.190682Z","steps":["trace[639500191] 'process raft request' (duration: 560.10746ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:19.190770Z","caller":"traceutil/trace.go:172","msg":"trace[1271572186] transaction","detail":"{read_only:false; number_of_response:0; response_revision:285; }","duration":"640.148833ms","start":"2026-04-15T17:54:18.550613Z","end":"2026-04-15T17:54:19.190762Z","steps":["trace[1271572186] 'process raft request' (duration: 639.784689ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:19.190804Z","caller":"traceutil/trace.go:172","msg":"trace[1150861883] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"639.416474ms","start":"2026-04-15T17:54:18.551379Z","end":"2026-04-15T17:54:19.190796Z","steps":["trace[1150861883] 'process raft request' (duration: 639.1049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:19.190807Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.630501Z","time spent":"560.271031ms","remote":"127.0.0.1:34994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3482,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:19.190842Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.551373Z","time spent":"639.450274ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4327,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:19.190970Z","caller":"traceutil/trace.go:172","msg":"trace[254016520] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:290; }","duration":"291.428296ms","start":"2026-04-15T17:54:18.899416Z","end":"2026-04-15T17:54:19.190844Z","steps":["trace[254016520] 'read index received' (duration: 290.510155ms)","trace[254016520] 'applied index is now lower than readState.Index' (duration: 917.181µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:19.190985Z","caller":"traceutil/trace.go:172","msg":"trace[1666703189] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"565.417596ms","start":"2026-04-15T17:54:18.625558Z","end":"2026-04-15T17:54:19.190976Z","steps":["trace[1666703189] 'process raft request' (duration: 565.018731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:19.191030Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.625535Z","time spent":"565.474886ms","remote":"127.0.0.1:34288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":637,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:19.190823Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.550609Z","time spent":"640.201074ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:19.191119Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"565.613919ms","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-15T17:54:19.191147Z","caller":"traceutil/trace.go:172","msg":"trace[393162395] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:289; }","duration":"565.641689ms","start":"2026-04-15T17:54:18.625497Z","end":"2026-04-15T17:54:19.191139Z","steps":["trace[393162395] 'agreement among raft nodes before linearized reading' (duration: 565.496267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:19.191148Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"564.586626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/controller\" limit:1 ","response":"range_response_count:1 size:3596"} {"level":"info","ts":"2026-04-15T17:54:19.191222Z","caller":"traceutil/trace.go:172","msg":"trace[449759660] range","detail":"{range_begin:/registry/minions/controller; range_end:; response_count:1; response_revision:289; }","duration":"564.731668ms","start":"2026-04-15T17:54:18.626474Z","end":"2026-04-15T17:54:19.191206Z","steps":["trace[449759660] 'agreement among raft nodes before linearized reading' (duration: 564.423894ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:19.190776Z","caller":"traceutil/trace.go:172","msg":"trace[1360283084] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"596.682143ms","start":"2026-04-15T17:54:18.594085Z","end":"2026-04-15T17:54:19.190767Z","steps":["trace[1360283084] 'process raft request' (duration: 596.44967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:19.191256Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.626457Z","time spent":"564.788728ms","remote":"127.0.0.1:34456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":32,"response count":1,"response size":3619,"request content":"key:\"/registry/minions/controller\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:19.191165Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.625475Z","time spent":"565.685189ms","remote":"127.0.0.1:34346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:19.192083Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:18.594060Z","time spent":"597.98854ms","remote":"127.0.0.1:34456","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:19.370633Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"134.460823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:19.370757Z","caller":"traceutil/trace.go:172","msg":"trace[1969735848] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:0; response_revision:293; }","duration":"134.597015ms","start":"2026-04-15T17:54:19.236133Z","end":"2026-04-15T17:54:19.370730Z","steps":["trace[1969735848] 'agreement among raft nodes before linearized reading' (duration: 69.367948ms)","trace[1969735848] 'range keys from in-memory index tree' (duration: 65.052135ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:19.370900Z","caller":"traceutil/trace.go:172","msg":"trace[378727219] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"147.949529ms","start":"2026-04-15T17:54:19.222909Z","end":"2026-04-15T17:54:19.370858Z","steps":["trace[378727219] 'process raft request' (duration: 82.646442ms)","trace[378727219] 'compare' (duration: 64.981363ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:19.371371Z","caller":"traceutil/trace.go:172","msg":"trace[1503824439] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"141.556821ms","start":"2026-04-15T17:54:19.229801Z","end":"2026-04-15T17:54:19.371358Z","steps":["trace[1503824439] 'process raft request' (duration: 140.977993ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:19.371923Z","caller":"traceutil/trace.go:172","msg":"trace[229381302] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"136.115103ms","start":"2026-04-15T17:54:19.235783Z","end":"2026-04-15T17:54:19.371898Z","steps":["trace[229381302] 'process raft request' (duration: 136.041862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:23.747281Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"121.700016ms","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-15T17:54:23.747341Z","caller":"traceutil/trace.go:172","msg":"trace[1274851024] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:349; }","duration":"121.773517ms","start":"2026-04-15T17:54:23.625557Z","end":"2026-04-15T17:54:23.747331Z","steps":["trace[1274851024] 'range keys from in-memory index tree' (duration: 121.541533ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:23.968779Z","caller":"traceutil/trace.go:172","msg":"trace[1608175125] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"132.865362ms","start":"2026-04-15T17:54:23.835883Z","end":"2026-04-15T17:54:23.968748Z","steps":["trace[1608175125] 'process raft request' (duration: 132.583798ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:24.190298Z","caller":"traceutil/trace.go:172","msg":"trace[335698968] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:363; }","duration":"214.615013ms","start":"2026-04-15T17:54:23.975651Z","end":"2026-04-15T17:54:24.190266Z","steps":["trace[335698968] 'read index received' (duration: 214.604593ms)","trace[335698968] 'applied index is now lower than readState.Index' (duration: 8.94µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:24.196373Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"220.688647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-15T17:54:24.196452Z","caller":"traceutil/trace.go:172","msg":"trace[1513665585] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:350; }","duration":"220.797608ms","start":"2026-04-15T17:54:23.975637Z","end":"2026-04-15T17:54:24.196435Z","steps":["trace[1513665585] 'agreement among raft nodes before linearized reading' (duration: 214.771475ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:24.196485Z","caller":"traceutil/trace.go:172","msg":"trace[250701954] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"222.417068ms","start":"2026-04-15T17:54:23.974046Z","end":"2026-04-15T17:54:24.196463Z","steps":["trace[250701954] 'process raft request' (duration: 216.476726ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:24.196543Z","caller":"traceutil/trace.go:172","msg":"trace[1141943352] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"220.326553ms","start":"2026-04-15T17:54:23.976182Z","end":"2026-04-15T17:54:24.196509Z","steps":["trace[1141943352] 'process raft request' (duration: 220.260372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:24.196626Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"170.98218ms","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-15T17:54:24.196696Z","caller":"traceutil/trace.go:172","msg":"trace[1662390777] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:352; }","duration":"171.053811ms","start":"2026-04-15T17:54:24.025620Z","end":"2026-04-15T17:54:24.196674Z","steps":["trace[1662390777] 'agreement among raft nodes before linearized reading' (duration: 170.877129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:24.196950Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"121.280126ms","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-15T17:54:24.196980Z","caller":"traceutil/trace.go:172","msg":"trace[1692427405] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:352; }","duration":"121.315696ms","start":"2026-04-15T17:54:24.075657Z","end":"2026-04-15T17:54:24.196972Z","steps":["trace[1692427405] 'agreement among raft nodes before linearized reading' (duration: 121.219975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:24.197089Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"142.1363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 ","response":"range_response_count:1 size:4948"} {"level":"info","ts":"2026-04-15T17:54:24.197149Z","caller":"traceutil/trace.go:172","msg":"trace[23912049] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-controller; range_end:; response_count:1; response_revision:352; }","duration":"142.2059ms","start":"2026-04-15T17:54:24.054928Z","end":"2026-04-15T17:54:24.197134Z","steps":["trace[23912049] 'agreement among raft nodes before linearized reading' (duration: 142.011768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:24.970197Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"694.924156ms","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-15T17:54:24.970325Z","caller":"traceutil/trace.go:172","msg":"trace[927450429] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:354; }","duration":"695.080478ms","start":"2026-04-15T17:54:24.275220Z","end":"2026-04-15T17:54:24.970301Z","steps":["trace[927450429] 'agreement among raft nodes before linearized reading' (duration: 75.519849ms)","trace[927450429] 'range keys from in-memory index tree' (duration: 619.266596ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:24.970397Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.275199Z","time spent":"695.165339ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:24.970235Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"619.400248ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T17:54:24.970972Z","caller":"traceutil/trace.go:172","msg":"trace[1639075798] linearizableReadLoop","detail":"{readStateIndex:368; appliedIndex:367; }","duration":"620.254748ms","start":"2026-04-15T17:54:24.350693Z","end":"2026-04-15T17:54:24.970948Z","steps":["trace[1639075798] 'read index received' (duration: 215.423822ms)","trace[1639075798] 'applied index is now lower than readState.Index' (duration: 404.825496ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:24.970990Z","caller":"traceutil/trace.go:172","msg":"trace[1207044504] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"676.638234ms","start":"2026-04-15T17:54:24.294334Z","end":"2026-04-15T17:54:24.970972Z","steps":["trace[1207044504] 'process raft request' (duration: 676.575434ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:24.971076Z","caller":"traceutil/trace.go:172","msg":"trace[2011654181] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"736.863136ms","start":"2026-04-15T17:54:24.234196Z","end":"2026-04-15T17:54:24.971059Z","steps":["trace[2011654181] 'process raft request' (duration: 116.580988ms)","trace[2011654181] 'compare' (duration: 619.279286ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:24.971165Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.234177Z","time spent":"736.950278ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:24.971351Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.294302Z","time spent":"676.734955ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:54:24.971429Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"645.202622ms","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-15T17:54:24.971475Z","caller":"traceutil/trace.go:172","msg":"trace[594527632] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:357; }","duration":"645.251242ms","start":"2026-04-15T17:54:24.326210Z","end":"2026-04-15T17:54:24.971462Z","steps":["trace[594527632] 'agreement among raft nodes before linearized reading' (duration: 645.126231ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:24.971482Z","caller":"traceutil/trace.go:172","msg":"trace[341564849] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"704.043237ms","start":"2026-04-15T17:54:24.267423Z","end":"2026-04-15T17:54:24.971466Z","steps":["trace[341564849] 'process raft request' (duration: 703.388219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:24.971511Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.326186Z","time spent":"645.315263ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:24.971573Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.267398Z","time spent":"704.125418ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:54:25.067047Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"690.454889ms","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-15T17:54:25.067160Z","caller":"traceutil/trace.go:172","msg":"trace[1649160115] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:357; }","duration":"690.576981ms","start":"2026-04-15T17:54:24.376556Z","end":"2026-04-15T17:54:25.067133Z","steps":["trace[1649160115] 'agreement among raft nodes before linearized reading' (duration: 690.301857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.067208Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.376532Z","time spent":"690.664512ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:25.067194Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"492.097366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-15T17:54:25.067264Z","caller":"traceutil/trace.go:172","msg":"trace[872199189] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:357; }","duration":"492.185147ms","start":"2026-04-15T17:54:24.575061Z","end":"2026-04-15T17:54:25.067246Z","steps":["trace[872199189] 'agreement among raft nodes before linearized reading' (duration: 491.961524ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:25.067281Z","caller":"traceutil/trace.go:172","msg":"trace[2035550973] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"636.589594ms","start":"2026-04-15T17:54:24.430671Z","end":"2026-04-15T17:54:25.067260Z","steps":["trace[2035550973] 'process raft request' (duration: 636.473093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.067431Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.430632Z","time spent":"636.730946ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:54:25.067437Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"290.461662ms","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-15T17:54:25.067486Z","caller":"traceutil/trace.go:172","msg":"trace[989975169] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:358; }","duration":"290.516663ms","start":"2026-04-15T17:54:24.776958Z","end":"2026-04-15T17:54:25.067475Z","steps":["trace[989975169] 'agreement among raft nodes before linearized reading' (duration: 290.381611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.067530Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"542.192535ms","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-15T17:54:25.067573Z","caller":"traceutil/trace.go:172","msg":"trace[1689008444] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:358; }","duration":"542.236146ms","start":"2026-04-15T17:54:24.525327Z","end":"2026-04-15T17:54:25.067563Z","steps":["trace[1689008444] 'agreement among raft nodes before linearized reading' (duration: 542.123455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.067602Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.525306Z","time spent":"542.286316ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:25.067726Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"581.889799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 ","response":"range_response_count:1 size:4948"} {"level":"info","ts":"2026-04-15T17:54:25.067758Z","caller":"traceutil/trace.go:172","msg":"trace[1217518291] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-controller; range_end:; response_count:1; response_revision:358; }","duration":"581.920859ms","start":"2026-04-15T17:54:24.485829Z","end":"2026-04-15T17:54:25.067750Z","steps":["trace[1217518291] 'agreement among raft nodes before linearized reading' (duration: 581.839198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.067782Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.485816Z","time spent":"581.95978ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":4971,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:25.067971Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"441.744883ms","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":"warn","ts":"2026-04-15T17:54:25.067983Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"392.392132ms","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-15T17:54:25.068021Z","caller":"traceutil/trace.go:172","msg":"trace[1155826434] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-cidrs-controller; range_end:; response_count:1; response_revision:358; }","duration":"392.431862ms","start":"2026-04-15T17:54:24.675579Z","end":"2026-04-15T17:54:25.068011Z","steps":["trace[1155826434] 'agreement among raft nodes before linearized reading' (duration: 392.308271ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:25.068025Z","caller":"traceutil/trace.go:172","msg":"trace[2044366319] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:358; }","duration":"441.790223ms","start":"2026-04-15T17:54:24.626213Z","end":"2026-04-15T17:54:25.068003Z","steps":["trace[2044366319] 'agreement among raft nodes before linearized reading' (duration: 441.680222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.068054Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.626187Z","time spent":"441.859184ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:25.068066Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.675561Z","time spent":"392.480784ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/service-cidrs-controller\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:25.067317Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.575047Z","time spent":"492.259888ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:25.068119Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"591.85183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-15T17:54:25.068168Z","caller":"traceutil/trace.go:172","msg":"trace[2032648178] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:358; }","duration":"591.89897ms","start":"2026-04-15T17:54:24.476252Z","end":"2026-04-15T17:54:25.068151Z","steps":["trace[2032648178] 'agreement among raft nodes before linearized reading' (duration: 591.776399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.068188Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"643.377127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-15T17:54:25.068198Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.476227Z","time spent":"591.962961ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" limit:1 "} {"level":"info","ts":"2026-04-15T17:54:25.068214Z","caller":"traceutil/trace.go:172","msg":"trace[118020938] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:358; }","duration":"643.401987ms","start":"2026-04-15T17:54:24.424804Z","end":"2026-04-15T17:54:25.068206Z","steps":["trace[118020938] 'agreement among raft nodes before linearized reading' (duration: 643.325986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.068237Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.424787Z","time spent":"643.444017ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:25.068269Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"342.396174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-15T17:54:25.068311Z","caller":"traceutil/trace.go:172","msg":"trace[773773307] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:358; }","duration":"342.494285ms","start":"2026-04-15T17:54:24.725804Z","end":"2026-04-15T17:54:25.068298Z","steps":["trace[773773307] 'agreement among raft nodes before linearized reading' (duration: 341.971399ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.068346Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.725784Z","time spent":"342.550635ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" limit:1 "} {"level":"info","ts":"2026-04-15T17:54:25.398058Z","caller":"traceutil/trace.go:172","msg":"trace[552691515] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:371; }","duration":"323.293202ms","start":"2026-04-15T17:54:25.074710Z","end":"2026-04-15T17:54:25.398003Z","steps":["trace[552691515] 'read index received' (duration: 323.284802ms)","trace[552691515] 'applied index is now lower than readState.Index' (duration: 6.94µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:25.405520Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"330.790993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-15T17:54:25.405665Z","caller":"traceutil/trace.go:172","msg":"trace[1306093721] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:358; }","duration":"330.901674ms","start":"2026-04-15T17:54:25.074696Z","end":"2026-04-15T17:54:25.405598Z","steps":["trace[1306093721] 'agreement among raft nodes before linearized reading' (duration: 323.434433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.405748Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:25.074678Z","time spent":"331.056506ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 "} {"level":"info","ts":"2026-04-15T17:54:25.405829Z","caller":"traceutil/trace.go:172","msg":"trace[179288092] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"429.914167ms","start":"2026-04-15T17:54:24.975898Z","end":"2026-04-15T17:54:25.405812Z","steps":["trace[179288092] 'process raft request' (duration: 422.175942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.405926Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.975873Z","time spent":"430.010697ms","remote":"127.0.0.1:34506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:25.406450Z","caller":"traceutil/trace.go:172","msg":"trace[506468729] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"428.428418ms","start":"2026-04-15T17:54:24.977996Z","end":"2026-04-15T17:54:25.406425Z","steps":["trace[506468729] 'process raft request' (duration: 427.542507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.406588Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.977981Z","time spent":"428.540059ms","remote":"127.0.0.1:34336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2147,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:25.406803Z","caller":"traceutil/trace.go:172","msg":"trace[2136954357] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"426.039849ms","start":"2026-04-15T17:54:24.980752Z","end":"2026-04-15T17:54:25.406791Z","steps":["trace[2136954357] 'process raft request' (duration: 425.014677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.406870Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.980741Z","time spent":"426.08873ms","remote":"127.0.0.1:34788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:25.406940Z","caller":"traceutil/trace.go:172","msg":"trace[528639494] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"425.568813ms","start":"2026-04-15T17:54:24.981352Z","end":"2026-04-15T17:54:25.406920Z","steps":["trace[528639494] 'process raft request' (duration: 425.062467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.407027Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.981343Z","time spent":"425.637325ms","remote":"127.0.0.1:34788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2194,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:25.407195Z","caller":"traceutil/trace.go:172","msg":"trace[500847927] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"425.626974ms","start":"2026-04-15T17:54:24.981555Z","end":"2026-04-15T17:54:25.407182Z","steps":["trace[500847927] 'process raft request' (duration: 424.916315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.407257Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:24.981546Z","time spent":"425.685225ms","remote":"127.0.0.1:34788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2299,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:25.410000Z","caller":"traceutil/trace.go:172","msg":"trace[2011610608] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"333.204922ms","start":"2026-04-15T17:54:25.076780Z","end":"2026-04-15T17:54:25.409985Z","steps":["trace[2011610608] 'process raft request' (duration: 333.08711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.410093Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:25.076761Z","time spent":"333.285683ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4741,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:25.410326Z","caller":"traceutil/trace.go:172","msg":"trace[1301190760] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"331.678844ms","start":"2026-04-15T17:54:25.078632Z","end":"2026-04-15T17:54:25.410311Z","steps":["trace[1301190760] 'process raft request' (duration: 331.577633ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:25.410358Z","caller":"traceutil/trace.go:172","msg":"trace[1690545754] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"332.063828ms","start":"2026-04-15T17:54:25.078280Z","end":"2026-04-15T17:54:25.410344Z","steps":["trace[1690545754] 'process raft request' (duration: 331.678384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.410394Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:25.078623Z","time spent":"331.743124ms","remote":"127.0.0.1:34288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":659,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:25.410443Z","caller":"traceutil/trace.go:172","msg":"trace[1705323723] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"327.959428ms","start":"2026-04-15T17:54:25.082474Z","end":"2026-04-15T17:54:25.410433Z","steps":["trace[1705323723] 'process raft request' (duration: 327.923718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.410415Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:25.078271Z","time spent":"332.119399ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":697,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:25.410533Z","caller":"traceutil/trace.go:172","msg":"trace[1502275195] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"330.098614ms","start":"2026-04-15T17:54:25.080412Z","end":"2026-04-15T17:54:25.410511Z","steps":["trace[1502275195] 'process raft request' (duration: 329.934792ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:25.410606Z","caller":"traceutil/trace.go:172","msg":"trace[1374085030] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"330.109694ms","start":"2026-04-15T17:54:25.080487Z","end":"2026-04-15T17:54:25.410597Z","steps":["trace[1374085030] 'process raft request' (duration: 329.884782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.410616Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:25.080394Z","time spent":"330.184325ms","remote":"127.0.0.1:35062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2102,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:25.410659Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:25.080478Z","time spent":"330.159475ms","remote":"127.0.0.1:34336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:25.410505Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:25.082464Z","time spent":"328.011989ms","remote":"127.0.0.1:34456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4019,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:25.410981Z","caller":"traceutil/trace.go:172","msg":"trace[1410310445] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"331.742004ms","start":"2026-04-15T17:54:25.079228Z","end":"2026-04-15T17:54:25.410970Z","steps":["trace[1410310445] 'process raft request' (duration: 331.012835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.411106Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:25.079213Z","time spent":"331.869476ms","remote":"127.0.0.1:34600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1045,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:25.410727Z","caller":"traceutil/trace.go:172","msg":"trace[729293776] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"331.230618ms","start":"2026-04-15T17:54:25.079477Z","end":"2026-04-15T17:54:25.410708Z","steps":["trace[729293776] 'process raft request' (duration: 330.794672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.411720Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:25.079466Z","time spent":"332.1875ms","remote":"127.0.0.1:34572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1378,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:25.412064Z","caller":"traceutil/trace.go:172","msg":"trace[291987083] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"331.914256ms","start":"2026-04-15T17:54:25.080134Z","end":"2026-04-15T17:54:25.412048Z","steps":["trace[291987083] 'process raft request' (duration: 330.174635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:25.412362Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:25.080114Z","time spent":"331.986888ms","remote":"127.0.0.1:34696","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":805,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:26.949068Z","caller":"traceutil/trace.go:172","msg":"trace[1351986829] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:418; }","duration":"197.794912ms","start":"2026-04-15T17:54:26.751250Z","end":"2026-04-15T17:54:26.949045Z","steps":["trace[1351986829] 'read index received' (duration: 197.786012ms)","trace[1351986829] 'applied index is now lower than readState.Index' (duration: 7.47µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:26.962687Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"211.407157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.233\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-15T17:54:26.962750Z","caller":"traceutil/trace.go:172","msg":"trace[1683131832] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"246.573123ms","start":"2026-04-15T17:54:26.716152Z","end":"2026-04-15T17:54:26.962725Z","steps":["trace[1683131832] 'process raft request' (duration: 232.912397ms)","trace[1683131832] 'compare' (duration: 13.510354ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:26.962790Z","caller":"traceutil/trace.go:172","msg":"trace[123713213] range","detail":"{range_begin:/registry/masterleases/199.19.213.233; range_end:; response_count:1; response_revision:404; }","duration":"211.536858ms","start":"2026-04-15T17:54:26.751235Z","end":"2026-04-15T17:54:26.962772Z","steps":["trace[123713213] 'agreement among raft nodes before linearized reading' (duration: 197.901533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:27.632441Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"250.135726ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T17:54:27.632564Z","caller":"traceutil/trace.go:172","msg":"trace[1613746732] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"622.435865ms","start":"2026-04-15T17:54:27.010112Z","end":"2026-04-15T17:54:27.632548Z","steps":["trace[1613746732] 'process raft request' (duration: 372.118657ms)","trace[1613746732] 'compare' (duration: 250.033325ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:27.632618Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:27.010083Z","time spent":"622.511697ms","remote":"127.0.0.1:34228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:28.934483Z","caller":"traceutil/trace.go:172","msg":"trace[1167460461] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"304.009225ms","start":"2026-04-15T17:54:28.630454Z","end":"2026-04-15T17:54:28.934463Z","steps":["trace[1167460461] 'process raft request' (duration: 303.832203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:28.934664Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:28.630426Z","time spent":"304.139806ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7500,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:54:29.517634Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"352.220773ms","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-15T17:54:29.517720Z","caller":"traceutil/trace.go:172","msg":"trace[437091163] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:410; }","duration":"352.324754ms","start":"2026-04-15T17:54:29.165379Z","end":"2026-04-15T17:54:29.517703Z","steps":["trace[437091163] 'range keys from in-memory index tree' (duration: 352.196272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:29.518540Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"245.525443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T17:54:29.518730Z","caller":"traceutil/trace.go:172","msg":"trace[1256871030] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"477.927239ms","start":"2026-04-15T17:54:29.040777Z","end":"2026-04-15T17:54:29.518704Z","steps":["trace[1256871030] 'process raft request' (duration: 232.157953ms)","trace[1256871030] 'compare' (duration: 244.737783ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:29.518955Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:29.040750Z","time spent":"478.111922ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:29.519154Z","caller":"traceutil/trace.go:172","msg":"trace[39847260] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"478.243083ms","start":"2026-04-15T17:54:29.040894Z","end":"2026-04-15T17:54:29.519138Z","steps":["trace[39847260] 'process raft request' (duration: 477.878209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:29.519269Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:29.040864Z","time spent":"478.329564ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:54:30.048112Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755373005739356855,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T17:54:30.549028Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755373005739356855,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T17:54:31.049733Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755373005739356855,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T17:54:31.393709Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.862765197s","expected-duration":"1s"} {"level":"info","ts":"2026-04-15T17:54:31.393977Z","caller":"traceutil/trace.go:172","msg":"trace[791423086] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:427; }","duration":"1.846598573s","start":"2026-04-15T17:54:29.547341Z","end":"2026-04-15T17:54:31.393940Z","steps":["trace[791423086] 'read index received' (duration: 1.846586323s)","trace[791423086] 'applied index is now lower than readState.Index' (duration: 10.28µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:31.696205Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.174404903s","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-15T17:54:31.696295Z","caller":"traceutil/trace.go:172","msg":"trace[2086489100] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:412; }","duration":"1.174512204s","start":"2026-04-15T17:54:30.521763Z","end":"2026-04-15T17:54:31.696276Z","steps":["trace[2086489100] 'range keys from in-memory index tree' (duration: 1.174337782s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:31.696362Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.148995236s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:31.696474Z","caller":"traceutil/trace.go:172","msg":"trace[1539884235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:412; }","duration":"2.149110648s","start":"2026-04-15T17:54:29.547336Z","end":"2026-04-15T17:54:31.696447Z","steps":["trace[1539884235] 'agreement among raft nodes before linearized reading' (duration: 1.846708644s)","trace[1539884235] 'range keys from in-memory index tree' (duration: 302.252592ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:31.696846Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:29.547322Z","time spent":"2.149508642s","remote":"127.0.0.1:34112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-15T17:54:31.696640Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"302.384824ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T17:54:31.697030Z","caller":"traceutil/trace.go:172","msg":"trace[2058928049] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"2.166148952s","start":"2026-04-15T17:54:29.530851Z","end":"2026-04-15T17:54:31.697000Z","steps":["trace[2058928049] 'process raft request' (duration: 1.863276153s)","trace[2058928049] 'compare' (duration: 302.09381ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:31.697148Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:29.530838Z","time spent":"2.166246653s","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5940,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:31.974267Z","caller":"traceutil/trace.go:172","msg":"trace[1708089979] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:428; }","duration":"425.839406ms","start":"2026-04-15T17:54:31.548394Z","end":"2026-04-15T17:54:31.974233Z","steps":["trace[1708089979] 'read index received' (duration: 425.831226ms)","trace[1708089979] 'applied index is now lower than readState.Index' (duration: 7.12µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:32.207474Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"659.065628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:32.207587Z","caller":"traceutil/trace.go:172","msg":"trace[139493523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:413; }","duration":"659.18858ms","start":"2026-04-15T17:54:31.548379Z","end":"2026-04-15T17:54:32.207568Z","steps":["trace[139493523] 'agreement among raft nodes before linearized reading' (duration: 425.958837ms)","trace[139493523] 'range keys from in-memory index tree' (duration: 233.044711ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:32.207626Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"233.168712ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-15T17:54:32.207650Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:31.548354Z","time spent":"659.288071ms","remote":"127.0.0.1:34150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-15T17:54:32.207784Z","caller":"traceutil/trace.go:172","msg":"trace[384930626] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"683.033794ms","start":"2026-04-15T17:54:31.524737Z","end":"2026-04-15T17:54:32.207771Z","steps":["trace[384930626] 'process raft request' (duration: 682.998824ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:32.207791Z","caller":"traceutil/trace.go:172","msg":"trace[1065670608] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:428; }","duration":"233.450355ms","start":"2026-04-15T17:54:31.974320Z","end":"2026-04-15T17:54:32.207771Z","steps":["trace[1065670608] 'read index received' (duration: 83.079198ms)","trace[1065670608] 'applied index is now lower than readState.Index' (duration: 150.367867ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:32.207775Z","caller":"traceutil/trace.go:172","msg":"trace[1825608094] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"2.669215551s","start":"2026-04-15T17:54:29.538527Z","end":"2026-04-15T17:54:32.207742Z","steps":["trace[1825608094] 'process raft request' (duration: 2.435860617s)","trace[1825608094] 'compare' (duration: 233.00262ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:32.207833Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:31.524729Z","time spent":"683.082965ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:54:32.207877Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"511.52814ms","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-15T17:54:32.207894Z","caller":"traceutil/trace.go:172","msg":"trace[802394827] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:416; }","duration":"511.555771ms","start":"2026-04-15T17:54:31.696333Z","end":"2026-04-15T17:54:32.207888Z","steps":["trace[802394827] 'agreement among raft nodes before linearized reading' (duration: 511.50096ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:32.207926Z","caller":"traceutil/trace.go:172","msg":"trace[941257153] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"683.345378ms","start":"2026-04-15T17:54:31.524573Z","end":"2026-04-15T17:54:32.207919Z","steps":["trace[941257153] 'process raft request' (duration: 683.125975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:32.207921Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:29.538503Z","time spent":"2.669346072s","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:54:32.207965Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:31.524546Z","time spent":"683.398448ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:54:32.208325Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"507.070297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-controller\" limit:1 ","response":"range_response_count:1 size:5955"} {"level":"info","ts":"2026-04-15T17:54:32.208384Z","caller":"traceutil/trace.go:172","msg":"trace[525874876] range","detail":"{range_begin:/registry/pods/kube-system/etcd-controller; range_end:; response_count:1; response_revision:416; }","duration":"507.127277ms","start":"2026-04-15T17:54:31.701238Z","end":"2026-04-15T17:54:32.208366Z","steps":["trace[525874876] 'agreement among raft nodes before linearized reading' (duration: 506.951315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:32.208439Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:31.701221Z","time spent":"507.201708ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":5978,"request content":"key:\"/registry/pods/kube-system/etcd-controller\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:54:32.447415Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"202.565358ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-15T17:54:32.587581Z","caller":"traceutil/trace.go:172","msg":"trace[805271043] linearizableReadLoop","detail":"{readStateIndex:432; appliedIndex:432; }","duration":"342.837605ms","start":"2026-04-15T17:54:32.244707Z","end":"2026-04-15T17:54:32.587545Z","steps":["trace[805271043] 'read index received' (duration: 342.827804ms)","trace[805271043] 'applied index is now lower than readState.Index' (duration: 8.641µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:32.587814Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"371.269042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:32.587861Z","caller":"traceutil/trace.go:172","msg":"trace[1000251610] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:416; }","duration":"371.341793ms","start":"2026-04-15T17:54:32.216508Z","end":"2026-04-15T17:54:32.587850Z","steps":["trace[1000251610] 'agreement among raft nodes before linearized reading' (duration: 371.215602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:32.587897Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:32.216498Z","time spent":"371.390914ms","remote":"127.0.0.1:34112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-15T17:54:32.588480Z","caller":"traceutil/trace.go:172","msg":"trace[1435300242] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"375.707045ms","start":"2026-04-15T17:54:32.212742Z","end":"2026-04-15T17:54:32.588450Z","steps":["trace[1435300242] 'process raft request' (duration: 375.359051ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:32.588553Z","caller":"traceutil/trace.go:172","msg":"trace[719174745] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"371.458815ms","start":"2026-04-15T17:54:32.217036Z","end":"2026-04-15T17:54:32.588495Z","steps":["trace[719174745] 'process raft request' (duration: 371.234192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:32.588626Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:32.212720Z","time spent":"375.818806ms","remote":"127.0.0.1:34288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":769,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:54:32.588807Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:32.217025Z","time spent":"371.659287ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5768,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:54:34.664221Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"142.738257ms","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-15T17:54:34.664324Z","caller":"traceutil/trace.go:172","msg":"trace[2111339098] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:420; }","duration":"142.863288ms","start":"2026-04-15T17:54:34.521437Z","end":"2026-04-15T17:54:34.664300Z","steps":["trace[2111339098] 'range keys from in-memory index tree' (duration: 142.663166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:34.664520Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.441686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:34.664586Z","caller":"traceutil/trace.go:172","msg":"trace[1315239933] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:420; }","duration":"116.536977ms","start":"2026-04-15T17:54:34.548035Z","end":"2026-04-15T17:54:34.664572Z","steps":["trace[1315239933] 'range keys from in-memory index tree' (duration: 116.380295ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:35.451381Z","caller":"traceutil/trace.go:172","msg":"trace[1208865197] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"124.542888ms","start":"2026-04-15T17:54:35.326817Z","end":"2026-04-15T17:54:35.451360Z","steps":["trace[1208865197] 'process raft request' (duration: 124.385416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:36.811118Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"288.646503ms","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-15T17:54:36.811234Z","caller":"traceutil/trace.go:172","msg":"trace[1715812292] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:423; }","duration":"288.794695ms","start":"2026-04-15T17:54:36.522418Z","end":"2026-04-15T17:54:36.811213Z","steps":["trace[1715812292] 'range keys from in-memory index tree' (duration: 288.559642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:36.811238Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"260.861497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:36.811338Z","caller":"traceutil/trace.go:172","msg":"trace[385704252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:423; }","duration":"260.970818ms","start":"2026-04-15T17:54:36.550342Z","end":"2026-04-15T17:54:36.811313Z","steps":["trace[385704252] 'range keys from in-memory index tree' (duration: 260.745545ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:37.058522Z","caller":"traceutil/trace.go:172","msg":"trace[506993813] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"151.531009ms","start":"2026-04-15T17:54:36.906961Z","end":"2026-04-15T17:54:37.058492Z","steps":["trace[506993813] 'process raft request' (duration: 122.589469ms)","trace[506993813] 'compare' (duration: 28.692027ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:38.638479Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.650514ms","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-15T17:54:38.638581Z","caller":"traceutil/trace.go:172","msg":"trace[531336867] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:426; }","duration":"116.770516ms","start":"2026-04-15T17:54:38.521789Z","end":"2026-04-15T17:54:38.638560Z","steps":["trace[531336867] 'range keys from in-memory index tree' (duration: 116.579843ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:40.742269Z","caller":"traceutil/trace.go:172","msg":"trace[1156368663] linearizableReadLoop","detail":"{readStateIndex:443; appliedIndex:443; }","duration":"220.457495ms","start":"2026-04-15T17:54:40.521783Z","end":"2026-04-15T17:54:40.742241Z","steps":["trace[1156368663] 'read index received' (duration: 220.447145ms)","trace[1156368663] 'applied index is now lower than readState.Index' (duration: 8.05µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:40.742578Z","caller":"traceutil/trace.go:172","msg":"trace[1405845158] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"376.954945ms","start":"2026-04-15T17:54:40.365590Z","end":"2026-04-15T17:54:40.742545Z","steps":["trace[1405845158] 'process raft request' (duration: 376.685902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:40.742698Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"220.672948ms","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-15T17:54:40.742802Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:40.365562Z","time spent":"377.125576ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:40.743095Z","caller":"traceutil/trace.go:172","msg":"trace[1315972256] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:426; }","duration":"221.085382ms","start":"2026-04-15T17:54:40.521771Z","end":"2026-04-15T17:54:40.742857Z","steps":["trace[1315972256] 'agreement among raft nodes before linearized reading' (duration: 220.594327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:40.768984Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"218.757965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:40.769098Z","caller":"traceutil/trace.go:172","msg":"trace[430150549] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:427; }","duration":"218.879696ms","start":"2026-04-15T17:54:40.550188Z","end":"2026-04-15T17:54:40.769067Z","steps":["trace[430150549] 'agreement among raft nodes before linearized reading' (duration: 216.958674ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:40.769005Z","caller":"traceutil/trace.go:172","msg":"trace[1992340435] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"399.590697ms","start":"2026-04-15T17:54:40.369394Z","end":"2026-04-15T17:54:40.768984Z","steps":["trace[1992340435] 'process raft request' (duration: 397.836147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:40.769546Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:40.369354Z","time spent":"399.998903ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:42.647493Z","caller":"traceutil/trace.go:172","msg":"trace[1040480017] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:445; }","duration":"125.527993ms","start":"2026-04-15T17:54:42.521883Z","end":"2026-04-15T17:54:42.647411Z","steps":["trace[1040480017] 'read index received' (duration: 125.514663ms)","trace[1040480017] 'applied index is now lower than readState.Index' (duration: 11.31µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:42.647569Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"125.664094ms","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-15T17:54:42.647634Z","caller":"traceutil/trace.go:172","msg":"trace[143770540] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:428; }","duration":"125.746655ms","start":"2026-04-15T17:54:42.521874Z","end":"2026-04-15T17:54:42.647620Z","steps":["trace[143770540] 'agreement among raft nodes before linearized reading' (duration: 125.629104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:42.881106Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"233.577654ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-15T17:54:42.882073Z","caller":"traceutil/trace.go:172","msg":"trace[395616552] linearizableReadLoop","detail":"{readStateIndex:446; appliedIndex:445; }","duration":"234.473074ms","start":"2026-04-15T17:54:42.647572Z","end":"2026-04-15T17:54:42.882045Z","steps":["trace[395616552] 'read index received' (duration: 148.269446ms)","trace[395616552] 'applied index is now lower than readState.Index' (duration: 86.200898ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:42.882214Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"332.003883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:42.882262Z","caller":"traceutil/trace.go:172","msg":"trace[1887325303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"332.064603ms","start":"2026-04-15T17:54:42.550181Z","end":"2026-04-15T17:54:42.882246Z","steps":["trace[1887325303] 'agreement among raft nodes before linearized reading' (duration: 331.959262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:42.882309Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:42.550154Z","time spent":"332.143845ms","remote":"127.0.0.1:34112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-15T17:54:42.882469Z","caller":"traceutil/trace.go:172","msg":"trace[1341212407] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"413.538037ms","start":"2026-04-15T17:54:42.468779Z","end":"2026-04-15T17:54:42.882317Z","steps":["trace[1341212407] 'process raft request' (duration: 413.160673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:54:42.882944Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:42.468750Z","time spent":"413.879131ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:42.983904Z","caller":"traceutil/trace.go:172","msg":"trace[1894367203] linearizableReadLoop","detail":"{readStateIndex:447; appliedIndex:447; }","duration":"100.318792ms","start":"2026-04-15T17:54:42.883551Z","end":"2026-04-15T17:54:42.983870Z","steps":["trace[1894367203] 'read index received' (duration: 100.298692ms)","trace[1894367203] 'applied index is now lower than readState.Index' (duration: 17.01µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:43.057184Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"173.603918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:54:43.057276Z","caller":"traceutil/trace.go:172","msg":"trace[394514357] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"173.708909ms","start":"2026-04-15T17:54:42.883544Z","end":"2026-04-15T17:54:43.057253Z","steps":["trace[394514357] 'agreement among raft nodes before linearized reading' (duration: 100.447983ms)","trace[394514357] 'range keys from in-memory index tree' (duration: 73.117085ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:43.057936Z","caller":"traceutil/trace.go:172","msg":"trace[1326086172] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"282.139854ms","start":"2026-04-15T17:54:42.775779Z","end":"2026-04-15T17:54:43.057919Z","steps":["trace[1326086172] 'process raft request' (duration: 282.090263ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:43.058172Z","caller":"traceutil/trace.go:172","msg":"trace[1417059338] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"309.44333ms","start":"2026-04-15T17:54:42.748701Z","end":"2026-04-15T17:54:43.058144Z","steps":["trace[1417059338] 'process raft request' (duration: 235.224102ms)","trace[1417059338] 'compare' (duration: 73.381358ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:43.059183Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:42.748678Z","time spent":"309.740884ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:54:49.325241Z","caller":"traceutil/trace.go:172","msg":"trace[377862987] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"243.954708ms","start":"2026-04-15T17:54:49.081265Z","end":"2026-04-15T17:54:49.325220Z","steps":["trace[377862987] 'process raft request' (duration: 243.813636ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:49.339962Z","caller":"traceutil/trace.go:172","msg":"trace[304570751] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"254.372846ms","start":"2026-04-15T17:54:49.085564Z","end":"2026-04-15T17:54:49.339937Z","steps":["trace[304570751] 'process raft request' (duration: 254.287235ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:49.513429Z","caller":"traceutil/trace.go:172","msg":"trace[1924307195] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"172.715226ms","start":"2026-04-15T17:54:49.340686Z","end":"2026-04-15T17:54:49.513401Z","steps":["trace[1924307195] 'process raft request' (duration: 128.801106ms)","trace[1924307195] 'compare' (duration: 43.799199ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:54:49.639733Z","caller":"traceutil/trace.go:172","msg":"trace[852825654] linearizableReadLoop","detail":"{readStateIndex:460; appliedIndex:460; }","duration":"117.105573ms","start":"2026-04-15T17:54:49.522594Z","end":"2026-04-15T17:54:49.639700Z","steps":["trace[852825654] 'read index received' (duration: 117.090483ms)","trace[852825654] 'applied index is now lower than readState.Index' (duration: 12.57µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:49.828412Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"305.801422ms","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-15T17:54:49.828544Z","caller":"traceutil/trace.go:172","msg":"trace[135638238] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:441; }","duration":"305.907563ms","start":"2026-04-15T17:54:49.522584Z","end":"2026-04-15T17:54:49.828491Z","steps":["trace[135638238] 'agreement among raft nodes before linearized reading' (duration: 117.219125ms)","trace[135638238] 'range keys from in-memory index tree' (duration: 188.553936ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:49.829605Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"189.76882ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T17:54:49.829785Z","caller":"traceutil/trace.go:172","msg":"trace[417075114] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"307.600782ms","start":"2026-04-15T17:54:49.522162Z","end":"2026-04-15T17:54:49.829763Z","steps":["trace[417075114] 'process raft request' (duration: 117.564189ms)","trace[417075114] 'compare' (duration: 189.501987ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:49.829970Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:54:49.522123Z","time spent":"307.798854ms","remote":"127.0.0.1:35054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3960,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:54:49.995382Z","caller":"traceutil/trace.go:172","msg":"trace[1706999056] linearizableReadLoop","detail":"{readStateIndex:470; appliedIndex:470; }","duration":"121.152799ms","start":"2026-04-15T17:54:49.874208Z","end":"2026-04-15T17:54:49.995361Z","steps":["trace[1706999056] 'read index received' (duration: 121.145879ms)","trace[1706999056] 'applied index is now lower than readState.Index' (duration: 5.96µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:54:49.999182Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"124.948183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" limit:1 ","response":"range_response_count:1 size:4477"} {"level":"info","ts":"2026-04-15T17:54:49.999258Z","caller":"traceutil/trace.go:172","msg":"trace[1790024773] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:451; }","duration":"125.039864ms","start":"2026-04-15T17:54:49.874197Z","end":"2026-04-15T17:54:49.999237Z","steps":["trace[1790024773] 'agreement among raft nodes before linearized reading' (duration: 121.250141ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:49.999316Z","caller":"traceutil/trace.go:172","msg":"trace[1954106447] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"126.693053ms","start":"2026-04-15T17:54:49.872606Z","end":"2026-04-15T17:54:49.999299Z","steps":["trace[1954106447] 'process raft request' (duration: 126.600772ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:54:49.999596Z","caller":"traceutil/trace.go:172","msg":"trace[289608931] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"128.081758ms","start":"2026-04-15T17:54:49.871496Z","end":"2026-04-15T17:54:49.999578Z","steps":["trace[289608931] 'process raft request' (duration: 124.005792ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:03.345115Z","caller":"traceutil/trace.go:172","msg":"trace[525087474] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"121.026399ms","start":"2026-04-15T17:55:03.224057Z","end":"2026-04-15T17:55:03.345083Z","steps":["trace[525087474] 'process raft request' (duration: 120.747136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:03.765255Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"243.472863ms","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-15T17:55:03.765356Z","caller":"traceutil/trace.go:172","msg":"trace[1591035854] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:484; }","duration":"243.593956ms","start":"2026-04-15T17:55:03.521743Z","end":"2026-04-15T17:55:03.765337Z","steps":["trace[1591035854] 'range keys from in-memory index tree' (duration: 243.407333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:03.765431Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"322.116764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T17:55:03.765654Z","caller":"traceutil/trace.go:172","msg":"trace[821245490] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"333.678082ms","start":"2026-04-15T17:55:03.431960Z","end":"2026-04-15T17:55:03.765638Z","steps":["trace[821245490] 'process raft request' (duration: 333.594451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:03.765718Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:03.431934Z","time spent":"333.755573ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:55:03.765858Z","caller":"traceutil/trace.go:172","msg":"trace[598867177] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"353.067996ms","start":"2026-04-15T17:55:03.412769Z","end":"2026-04-15T17:55:03.765837Z","steps":["trace[598867177] 'process raft request' (duration: 30.462397ms)","trace[598867177] 'compare' (duration: 321.870321ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:55:03.765993Z","caller":"traceutil/trace.go:172","msg":"trace[1436334557] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"275.144474ms","start":"2026-04-15T17:55:03.490794Z","end":"2026-04-15T17:55:03.765938Z","steps":["trace[1436334557] 'read index received' (duration: 55.956769ms)","trace[1436334557] 'applied index is now lower than readState.Index' (duration: 219.186315ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:03.766101Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"275.319966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:03.766137Z","caller":"traceutil/trace.go:172","msg":"trace[498494221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"275.355197ms","start":"2026-04-15T17:55:03.490771Z","end":"2026-04-15T17:55:03.766126Z","steps":["trace[498494221] 'agreement among raft nodes before linearized reading' (duration: 275.293606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:03.766297Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.31998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T17:55:03.766464Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"219.398727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T17:55:03.766563Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:03.412746Z","time spent":"353.479842ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:55:03.767512Z","caller":"traceutil/trace.go:172","msg":"trace[508629069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"220.439089ms","start":"2026-04-15T17:55:03.547051Z","end":"2026-04-15T17:55:03.767490Z","steps":["trace[508629069] 'agreement among raft nodes before linearized reading' (duration: 219.107974ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:03.768069Z","caller":"traceutil/trace.go:172","msg":"trace[2050323821] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:0; response_revision:486; }","duration":"112.09129ms","start":"2026-04-15T17:55:03.655959Z","end":"2026-04-15T17:55:03.768050Z","steps":["trace[2050323821] 'agreement among raft nodes before linearized reading' (duration: 110.28274ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:04.241045Z","caller":"traceutil/trace.go:172","msg":"trace[454078453] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"364.891393ms","start":"2026-04-15T17:55:03.876108Z","end":"2026-04-15T17:55:04.240999Z","steps":["trace[454078453] 'process raft request' (duration: 364.645831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:04.241178Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:03.876084Z","time spent":"365.038525ms","remote":"127.0.0.1:34316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317276,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:55:04.438215Z","caller":"traceutil/trace.go:172","msg":"trace[689760567] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"130.732964ms","start":"2026-04-15T17:55:04.307465Z","end":"2026-04-15T17:55:04.438198Z","steps":["trace[689760567] 'process raft request' (duration: 128.104755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:07.022047Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755373005739357104,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T17:55:07.522896Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755373005739357104,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T17:55:08.023543Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755373005739357104,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T17:55:08.524313Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755373005739357104,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T17:55:08.525547Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.067421562s","expected-duration":"1s"} {"level":"info","ts":"2026-04-15T17:55:08.525914Z","caller":"traceutil/trace.go:172","msg":"trace[860802802] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:546; }","duration":"2.004389849s","start":"2026-04-15T17:55:06.521487Z","end":"2026-04-15T17:55:08.525877Z","steps":["trace[860802802] 'read index received' (duration: 2.004380238s)","trace[860802802] 'applied index is now lower than readState.Index' (duration: 7.56µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:08.526123Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.004589351s","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-15T17:55:08.526169Z","caller":"traceutil/trace.go:172","msg":"trace[3688341] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:523; }","duration":"2.004674732s","start":"2026-04-15T17:55:06.521482Z","end":"2026-04-15T17:55:08.526156Z","steps":["trace[3688341] 'agreement among raft nodes before linearized reading' (duration: 2.00454052s)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:08.526210Z","caller":"traceutil/trace.go:172","msg":"trace[1368677461] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"2.06818137s","start":"2026-04-15T17:55:06.458010Z","end":"2026-04-15T17:55:08.526192Z","steps":["trace[1368677461] 'process raft request' (duration: 2.068034468s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.526347Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.457990Z","time spent":"2.068272102s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:55:08.549041Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.999265721s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-15T17:55:08.549111Z","caller":"traceutil/trace.go:172","msg":"trace[391648979] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999352262s","start":"2026-04-15T17:55:06.549745Z","end":"2026-04-15T17:55:08.549098Z","steps":["trace[391648979] 'agreement among raft nodes before linearized reading' (duration: 1.999262841s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.549161Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.549730Z","time spent":"1.999425143s","remote":"127.0.0.1:34112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/15 17:55:08 WARNING: [core] [Server #5]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-04-15T17:55:08.628199Z","caller":"traceutil/trace.go:172","msg":"trace[1420247077] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:547; }","duration":"102.17837ms","start":"2026-04-15T17:55:08.525993Z","end":"2026-04-15T17:55:08.628171Z","steps":["trace[1420247077] 'read index received' (duration: 102.17075ms)","trace[1420247077] 'applied index is now lower than readState.Index' (duration: 6.69µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:08.628496Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.873198091s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.233\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-15T17:55:08.628639Z","caller":"traceutil/trace.go:172","msg":"trace[427089005] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"2.167001794s","start":"2026-04-15T17:55:06.461619Z","end":"2026-04-15T17:55:08.628621Z","steps":["trace[427089005] 'process raft request' (duration: 2.16656803s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.628730Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.461597Z","time spent":"2.167080755s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:55:08.629091Z","caller":"traceutil/trace.go:172","msg":"trace[1512788371] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"2.166053834s","start":"2026-04-15T17:55:06.462976Z","end":"2026-04-15T17:55:08.629030Z","steps":["trace[1512788371] 'process raft request' (duration: 2.165517248s)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:08.629211Z","caller":"traceutil/trace.go:172","msg":"trace[277153935] range","detail":"{range_begin:/registry/masterleases/199.19.213.233; range_end:; response_count:1; response_revision:524; }","duration":"1.873935329s","start":"2026-04-15T17:55:06.755265Z","end":"2026-04-15T17:55:08.629200Z","steps":["trace[277153935] 'agreement among raft nodes before linearized reading' (duration: 1.873047189s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.629263Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.755241Z","time spent":"1.874011909s","remote":"127.0.0.1:34228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.233\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:55:08.629273Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.462953Z","time spent":"2.166242156s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:55:08.630100Z","caller":"traceutil/trace.go:172","msg":"trace[1996021857] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"2.159650313s","start":"2026-04-15T17:55:06.470429Z","end":"2026-04-15T17:55:08.630079Z","steps":["trace[1996021857] 'process raft request' (duration: 2.158680663s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.630245Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.470408Z","time spent":"2.159774034s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:55:08.630538Z","caller":"traceutil/trace.go:172","msg":"trace[406639749] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"2.15661371s","start":"2026-04-15T17:55:06.473912Z","end":"2026-04-15T17:55:08.630526Z","steps":["trace[406639749] 'process raft request' (duration: 2.156124445s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.630597Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.473882Z","time spent":"2.156689491s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:55:08.630942Z","caller":"traceutil/trace.go:172","msg":"trace[1045674709] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"2.139763155s","start":"2026-04-15T17:55:06.491167Z","end":"2026-04-15T17:55:08.630931Z","steps":["trace[1045674709] 'process raft request' (duration: 2.139255079s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.631060Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.491149Z","time spent":"2.139854655s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:55:08.631890Z","caller":"traceutil/trace.go:172","msg":"trace[749397113] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"2.137637481s","start":"2026-04-15T17:55:06.494241Z","end":"2026-04-15T17:55:08.631879Z","steps":["trace[749397113] 'process raft request' (duration: 2.13750351s)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:08.631975Z","caller":"traceutil/trace.go:172","msg":"trace[1861915597] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"2.134491896s","start":"2026-04-15T17:55:06.497463Z","end":"2026-04-15T17:55:08.631955Z","steps":["trace[1861915597] 'process raft request' (duration: 2.134357614s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.632093Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.497423Z","time spent":"2.134620778s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:55:08.632010Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.494231Z","time spent":"2.137723232s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:55:08.632746Z","caller":"traceutil/trace.go:172","msg":"trace[1999356316] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"850.46459ms","start":"2026-04-15T17:55:07.782266Z","end":"2026-04-15T17:55:08.632731Z","steps":["trace[1999356316] 'process raft request' (duration: 850.42903ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:08.632802Z","caller":"traceutil/trace.go:172","msg":"trace[48728892] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.981499163s","start":"2026-04-15T17:55:06.651272Z","end":"2026-04-15T17:55:08.632772Z","steps":["trace[48728892] 'process raft request' (duration: 1.981329141s)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:08.632855Z","caller":"traceutil/trace.go:172","msg":"trace[1665677440] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"2.111415423s","start":"2026-04-15T17:55:06.521425Z","end":"2026-04-15T17:55:08.632840Z","steps":["trace[1665677440] 'process raft request' (duration: 2.110971098s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.634142Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.651246Z","time spent":"1.982745936s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:55:08.633889Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:07.782253Z","time spent":"851.592393ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:55:08.632891Z","caller":"traceutil/trace.go:172","msg":"trace[1598841162] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"2.076419247s","start":"2026-04-15T17:55:06.556460Z","end":"2026-04-15T17:55:08.632879Z","steps":["trace[1598841162] 'process raft request' (duration: 2.076066793s)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:08.633215Z","caller":"traceutil/trace.go:172","msg":"trace[1680853512] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"854.794048ms","start":"2026-04-15T17:55:07.778404Z","end":"2026-04-15T17:55:08.633198Z","steps":["trace[1680853512] 'process raft request' (duration: 854.250612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.634221Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.521399Z","time spent":"2.112793217s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:55:08.635283Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:07.778369Z","time spent":"856.8012ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:55:08.635444Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.556440Z","time spent":"2.07857073s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:55:08.632632Z","caller":"traceutil/trace.go:172","msg":"trace[797034608] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"2.11848556s","start":"2026-04-15T17:55:06.514093Z","end":"2026-04-15T17:55:08.632578Z","steps":["trace[797034608] 'process raft request' (duration: 2.117836043s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.637550Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:06.514073Z","time spent":"2.123351004s","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:55:08.650322Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"122.992549ms","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-15T17:55:08.650380Z","caller":"traceutil/trace.go:172","msg":"trace[583708518] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:537; }","duration":"123.06334ms","start":"2026-04-15T17:55:08.527306Z","end":"2026-04-15T17:55:08.650369Z","steps":["trace[583708518] 'agreement among raft nodes before linearized reading' (duration: 122.963389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:08.650548Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.140669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:08.650561Z","caller":"traceutil/trace.go:172","msg":"trace[244945143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"101.154709ms","start":"2026-04-15T17:55:08.549402Z","end":"2026-04-15T17:55:08.650557Z","steps":["trace[244945143] 'agreement among raft nodes before linearized reading' (duration: 101.129659ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:08.650943Z","caller":"traceutil/trace.go:172","msg":"trace[386209787] transaction","detail":"{read_only:false; number_of_response:1; response_revision:539; }","duration":"114.825429ms","start":"2026-04-15T17:55:08.536110Z","end":"2026-04-15T17:55:08.650935Z","steps":["trace[386209787] 'process raft request' (duration: 114.761858ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:08.651547Z","caller":"traceutil/trace.go:172","msg":"trace[1559413076] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"116.144233ms","start":"2026-04-15T17:55:08.535378Z","end":"2026-04-15T17:55:08.651522Z","steps":["trace[1559413076] 'process raft request' (duration: 115.454376ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:08.651865Z","caller":"traceutil/trace.go:172","msg":"trace[428287738] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"117.68267ms","start":"2026-04-15T17:55:08.534175Z","end":"2026-04-15T17:55:08.651858Z","steps":["trace[428287738] 'process raft request' (duration: 116.595158ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:09.921646Z","caller":"traceutil/trace.go:172","msg":"trace[936850385] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"254.742919ms","start":"2026-04-15T17:55:09.666882Z","end":"2026-04-15T17:55:09.921625Z","steps":["trace[936850385] 'process raft request' (duration: 254.289924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:10.430731Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"356.731309ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T17:55:10.430868Z","caller":"traceutil/trace.go:172","msg":"trace[1633214025] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"743.678424ms","start":"2026-04-15T17:55:09.687168Z","end":"2026-04-15T17:55:10.430847Z","steps":["trace[1633214025] 'process raft request' (duration: 386.744063ms)","trace[1633214025] 'compare' (duration: 356.271844ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:10.430940Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:09.687144Z","time spent":"743.766205ms","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:55:10.431333Z","caller":"traceutil/trace.go:172","msg":"trace[865600382] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"458.269339ms","start":"2026-04-15T17:55:09.973041Z","end":"2026-04-15T17:55:10.431310Z","steps":["trace[865600382] 'process raft request' (duration: 458.095467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:10.431557Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:09.973017Z","time spent":"458.40928ms","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15664,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:55:10.598138Z","caller":"traceutil/trace.go:172","msg":"trace[182909058] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:626; }","duration":"126.974238ms","start":"2026-04-15T17:55:10.471134Z","end":"2026-04-15T17:55:10.598108Z","steps":["trace[182909058] 'read index received' (duration: 126.963438ms)","trace[182909058] 'applied index is now lower than readState.Index' (duration: 9.29µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:10.621404Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"150.235952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" limit:1 ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-04-15T17:55:10.621578Z","caller":"traceutil/trace.go:172","msg":"trace[1632524117] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:598; }","duration":"150.420994ms","start":"2026-04-15T17:55:10.471129Z","end":"2026-04-15T17:55:10.621550Z","steps":["trace[1632524117] 'agreement among raft nodes before linearized reading' (duration: 127.296142ms)","trace[1632524117] 'range keys from in-memory index tree' (duration: 22.748208ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:55:10.622247Z","caller":"traceutil/trace.go:172","msg":"trace[648636957] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"504.353903ms","start":"2026-04-15T17:55:10.117872Z","end":"2026-04-15T17:55:10.622226Z","steps":["trace[648636957] 'process raft request' (duration: 480.471392ms)","trace[648636957] 'compare' (duration: 23.060082ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:10.622366Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:10.117839Z","time spent":"504.466974ms","remote":"127.0.0.1:34242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:55:10.637844Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"115.902198ms","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-15T17:55:10.637935Z","caller":"traceutil/trace.go:172","msg":"trace[1329664220] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:599; }","duration":"116.003919ms","start":"2026-04-15T17:55:10.521915Z","end":"2026-04-15T17:55:10.637919Z","steps":["trace[1329664220] 'agreement among raft nodes before linearized reading' (duration: 115.869508ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:10.637996Z","caller":"traceutil/trace.go:172","msg":"trace[1295876785] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"136.328371ms","start":"2026-04-15T17:55:10.501657Z","end":"2026-04-15T17:55:10.637985Z","steps":["trace[1295876785] 'process raft request' (duration: 136.179719ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:16.302956Z","caller":"traceutil/trace.go:172","msg":"trace[1433685339] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"662.012751ms","start":"2026-04-15T17:55:15.640913Z","end":"2026-04-15T17:55:16.302926Z","steps":["trace[1433685339] 'process raft request' (duration: 661.790889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:16.303185Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:15.640832Z","time spent":"662.236274ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18507,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:55:16.942359Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755373005739357290,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T17:55:16.993785Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"472.085249ms","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-15T17:55:16.993902Z","caller":"traceutil/trace.go:172","msg":"trace[367085061] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:627; }","duration":"472.219151ms","start":"2026-04-15T17:55:16.521666Z","end":"2026-04-15T17:55:16.993885Z","steps":["trace[367085061] 'range keys from in-memory index tree' (duration: 472.029959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:17.442821Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755373005739357290,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T17:55:17.550554Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.14474852s","expected-duration":"1s"} {"level":"info","ts":"2026-04-15T17:55:17.550910Z","caller":"traceutil/trace.go:172","msg":"trace[1820141620] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:657; }","duration":"1.108938542s","start":"2026-04-15T17:55:16.441922Z","end":"2026-04-15T17:55:17.550861Z","steps":["trace[1820141620] 'read index received' (duration: 1.108921512s)","trace[1820141620] 'applied index is now lower than readState.Index' (duration: 14.24µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:17.551664Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.109694651s","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-15T17:55:17.551848Z","caller":"traceutil/trace.go:172","msg":"trace[704108432] range","detail":"{range_begin:/registry/certificatesigningrequests; range_end:; response_count:0; response_revision:627; }","duration":"1.109865352s","start":"2026-04-15T17:55:16.441909Z","end":"2026-04-15T17:55:17.551774Z","steps":["trace[704108432] 'agreement among raft nodes before linearized reading' (duration: 1.109135814s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:17.552106Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:16.441878Z","time spent":"1.110035455s","remote":"127.0.0.1:34572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":28,"request content":"key:\"/registry/certificatesigningrequests\" limit:1 "} {"level":"info","ts":"2026-04-15T17:55:17.557907Z","caller":"traceutil/trace.go:172","msg":"trace[1262259392] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.686263853s","start":"2026-04-15T17:55:15.871616Z","end":"2026-04-15T17:55:17.557880Z","steps":["trace[1262259392] 'process raft request' (duration: 1.680037575s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:17.558091Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:15.871571Z","time spent":"1.686408115s","remote":"127.0.0.1:34316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:55:17.730595Z","caller":"traceutil/trace.go:172","msg":"trace[826274332] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:658; }","duration":"179.50015ms","start":"2026-04-15T17:55:17.551050Z","end":"2026-04-15T17:55:17.730550Z","steps":["trace[826274332] 'read index received' (duration: 179.482029ms)","trace[826274332] 'applied index is now lower than readState.Index' (duration: 15.151µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:17.730808Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.181106261s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T17:55:17.730782Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.121987123s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:17.730865Z","caller":"traceutil/trace.go:172","msg":"trace[1834542173] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"1.181154302s","start":"2026-04-15T17:55:16.549680Z","end":"2026-04-15T17:55:17.730834Z","steps":["trace[1834542173] 'agreement among raft nodes before linearized reading' (duration: 1.181062571s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:17.730865Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"736.820883ms","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-15T17:55:17.730976Z","caller":"traceutil/trace.go:172","msg":"trace[145436818] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:628; }","duration":"737.024665ms","start":"2026-04-15T17:55:16.993937Z","end":"2026-04-15T17:55:17.730961Z","steps":["trace[145436818] 'agreement among raft nodes before linearized reading' (duration: 736.736232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:17.730921Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:16.549657Z","time spent":"1.181256014s","remote":"127.0.0.1:34150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-15T17:55:17.730913Z","caller":"traceutil/trace.go:172","msg":"trace[1684055000] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.367576788s","start":"2026-04-15T17:55:16.363304Z","end":"2026-04-15T17:55:17.730881Z","steps":["trace[1684055000] 'process raft request' (duration: 1.367317865s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:17.731310Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"976.183865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.233\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-15T17:55:17.731349Z","caller":"traceutil/trace.go:172","msg":"trace[557220567] range","detail":"{range_begin:/registry/masterleases/199.19.213.233; range_end:; response_count:1; response_revision:628; }","duration":"976.225425ms","start":"2026-04-15T17:55:16.755116Z","end":"2026-04-15T17:55:17.731341Z","steps":["trace[557220567] 'agreement among raft nodes before linearized reading' (duration: 975.484137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:17.731348Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:16.363264Z","time spent":"1.367975913s","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:55:17.731391Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:16.755093Z","time spent":"976.289326ms","remote":"127.0.0.1:34228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.233\" limit:1 "} {"level":"info","ts":"2026-04-15T17:55:17.730914Z","caller":"traceutil/trace.go:172","msg":"trace[355798011] range","detail":"{range_begin:/registry/storageclasses; range_end:; response_count:0; response_revision:628; }","duration":"1.122151964s","start":"2026-04-15T17:55:16.608744Z","end":"2026-04-15T17:55:17.730896Z","steps":["trace[355798011] 'agreement among raft nodes before linearized reading' (duration: 1.121941472s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:17.731611Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:16.608708Z","time spent":"1.122885722s","remote":"127.0.0.1:34848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/storageclasses\" limit:1 "} {"level":"info","ts":"2026-04-15T17:55:17.731641Z","caller":"traceutil/trace.go:172","msg":"trace[204013513] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.047665607s","start":"2026-04-15T17:55:16.683964Z","end":"2026-04-15T17:55:17.731629Z","steps":["trace[204013513] 'process raft request' (duration: 1.046890279s)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:17.731192Z","caller":"traceutil/trace.go:172","msg":"trace[2128473857] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.047170652s","start":"2026-04-15T17:55:16.684011Z","end":"2026-04-15T17:55:17.731182Z","steps":["trace[2128473857] 'process raft request' (duration: 1.047107602s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:17.731738Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:16.683925Z","time spent":"1.047743119s","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:55:17.731799Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:16.683969Z","time spent":"1.047756598s","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:55:17.746220Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"181.772145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:17.746287Z","caller":"traceutil/trace.go:172","msg":"trace[1356143498] range","detail":"{range_begin:/registry/configmaps; range_end:; response_count:0; response_revision:631; }","duration":"181.858806ms","start":"2026-04-15T17:55:17.564414Z","end":"2026-04-15T17:55:17.746273Z","steps":["trace[1356143498] 'agreement among raft nodes before linearized reading' (duration: 181.723364ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:17.746364Z","caller":"traceutil/trace.go:172","msg":"trace[778119634] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"121.619944ms","start":"2026-04-15T17:55:17.624731Z","end":"2026-04-15T17:55:17.746351Z","steps":["trace[778119634] 'process raft request' (duration: 121.519353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:18.445021Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755373005739357304,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-15T17:55:18.553675Z","caller":"traceutil/trace.go:172","msg":"trace[104902611] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:663; }","duration":"609.57747ms","start":"2026-04-15T17:55:17.944056Z","end":"2026-04-15T17:55:18.553633Z","steps":["trace[104902611] 'read index received' (duration: 609.56213ms)","trace[104902611] 'applied index is now lower than readState.Index' (duration: 13.09µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:18.612748Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"668.673538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:18.612828Z","caller":"traceutil/trace.go:172","msg":"trace[143781874] range","detail":"{range_begin:/registry/ingress; range_end:; response_count:0; response_revision:632; }","duration":"668.771589ms","start":"2026-04-15T17:55:17.944040Z","end":"2026-04-15T17:55:18.612812Z","steps":["trace[143781874] 'agreement among raft nodes before linearized reading' (duration: 609.792463ms)","trace[143781874] 'range keys from in-memory index tree' (duration: 58.845995ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:18.612866Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:17.944018Z","time spent":"668.84001ms","remote":"127.0.0.1:34624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":28,"request content":"key:\"/registry/ingress\" limit:1 "} {"level":"info","ts":"2026-04-15T17:55:18.613086Z","caller":"traceutil/trace.go:172","msg":"trace[479139538] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"852.303203ms","start":"2026-04-15T17:55:17.760748Z","end":"2026-04-15T17:55:18.613051Z","steps":["trace[479139538] 'process raft request' (duration: 793.013443ms)","trace[479139538] 'compare' (duration: 59.106988ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:18.613319Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:17.760721Z","time spent":"852.486674ms","remote":"127.0.0.1:34228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:55:18.642432Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"213.286502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:18.642591Z","caller":"traceutil/trace.go:172","msg":"trace[1888210570] range","detail":"{range_begin:/registry/priorityclasses; range_end:; response_count:0; response_revision:633; }","duration":"213.457604ms","start":"2026-04-15T17:55:18.429088Z","end":"2026-04-15T17:55:18.642546Z","steps":["trace[1888210570] 'agreement among raft nodes before linearized reading' (duration: 213.200691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:18.642813Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"367.281233ms","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-15T17:55:18.642885Z","caller":"traceutil/trace.go:172","msg":"trace[38782403] range","detail":"{range_begin:/registry/daemonsets; range_end:; response_count:0; response_revision:633; }","duration":"367.373734ms","start":"2026-04-15T17:55:18.275494Z","end":"2026-04-15T17:55:18.642868Z","steps":["trace[38782403] 'agreement among raft nodes before linearized reading' (duration: 367.143782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:18.642930Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:18.275462Z","time spent":"367.458825ms","remote":"127.0.0.1:35036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":28,"request content":"key:\"/registry/daemonsets\" limit:1 "} {"level":"warn","ts":"2026-04-15T17:55:18.643135Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"242.308575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/servicecidrs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T17:55:18.643189Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"337.430581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:18.643222Z","caller":"traceutil/trace.go:172","msg":"trace[320343442] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations; range_end:; response_count:0; response_revision:633; }","duration":"337.461981ms","start":"2026-04-15T17:55:18.305749Z","end":"2026-04-15T17:55:18.643211Z","steps":["trace[320343442] 'agreement among raft nodes before linearized reading' (duration: 337.40756ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:18.643193Z","caller":"traceutil/trace.go:172","msg":"trace[1073937448] range","detail":"{range_begin:/registry/servicecidrs; range_end:; response_count:0; response_revision:633; }","duration":"242.370516ms","start":"2026-04-15T17:55:18.400806Z","end":"2026-04-15T17:55:18.643177Z","steps":["trace[1073937448] 'agreement among raft nodes before linearized reading' (duration: 242.266774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:18.643258Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:18.305725Z","time spent":"337.525441ms","remote":"127.0.0.1:35094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 "} {"level":"info","ts":"2026-04-15T17:55:18.643572Z","caller":"traceutil/trace.go:172","msg":"trace[1432507942] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"474.729225ms","start":"2026-04-15T17:55:18.168821Z","end":"2026-04-15T17:55:18.643551Z","steps":["trace[1432507942] 'process raft request' (duration: 473.782654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:18.643679Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:18.168768Z","time spent":"474.846205ms","remote":"127.0.0.1:34316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:55:19.207520Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"218.053591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T17:55:19.207695Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"137.046687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T17:55:19.208386Z","caller":"traceutil/trace.go:172","msg":"trace[2097813628] range","detail":"{range_begin:/registry/resourcequotas; range_end:; response_count:0; response_revision:634; }","duration":"218.206712ms","start":"2026-04-15T17:55:18.989419Z","end":"2026-04-15T17:55:19.207625Z","steps":["trace[2097813628] 'agreement among raft nodes before linearized reading' (duration: 81.134245ms)","trace[2097813628] 'range keys from in-memory index tree' (duration: 136.872296ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:55:19.208391Z","caller":"traceutil/trace.go:172","msg":"trace[1527231841] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"103.702128ms","start":"2026-04-15T17:55:19.104651Z","end":"2026-04-15T17:55:19.208353Z","steps":["trace[1527231841] 'read index received' (duration: 80.241µs)","trace[1527231841] 'applied index is now lower than readState.Index' (duration: 103.620207ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:19.208571Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"103.90415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:19.208651Z","caller":"traceutil/trace.go:172","msg":"trace[1457439792] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:635; }","duration":"104.003511ms","start":"2026-04-15T17:55:19.104631Z","end":"2026-04-15T17:55:19.208634Z","steps":["trace[1457439792] 'agreement among raft nodes before linearized reading' (duration: 103.83603ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:19.208879Z","caller":"traceutil/trace.go:172","msg":"trace[335009104] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"495.080171ms","start":"2026-04-15T17:55:18.713279Z","end":"2026-04-15T17:55:19.208359Z","steps":["trace[335009104] 'process raft request' (duration: 357.304136ms)","trace[335009104] 'compare' (duration: 136.761114ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:19.209004Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:18.713238Z","time spent":"495.689118ms","remote":"127.0.0.1:34540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2676,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T17:55:21.221166Z","caller":"traceutil/trace.go:172","msg":"trace[823459234] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"348.621619ms","start":"2026-04-15T17:55:20.872522Z","end":"2026-04-15T17:55:21.221143Z","steps":["trace[823459234] 'process raft request' (duration: 348.232635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:21.222318Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:20.872500Z","time spent":"348.852081ms","remote":"127.0.0.1:34288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":767,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T17:55:23.629521Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49180","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:23.700554Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49210","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:23.717322Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49226","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:23.907110Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49254","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:23.933064Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49280","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:23.959771Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49292","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:23.982698Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49320","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.007491Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49330","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.032670Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49334","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.045412Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49348","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-15T17:55:24.072795Z","caller":"traceutil/trace.go:172","msg":"trace[570474279] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"100.599956ms","start":"2026-04-15T17:55:23.972174Z","end":"2026-04-15T17:55:24.072774Z","steps":["trace[570474279] 'process raft request' (duration: 100.520646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:24.072828Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"100.435275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:24.072909Z","caller":"traceutil/trace.go:172","msg":"trace[2111939910] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes; range_end:; response_count:0; response_revision:674; }","duration":"100.536387ms","start":"2026-04-15T17:55:23.972357Z","end":"2026-04-15T17:55:24.072893Z","steps":["trace[2111939910] 'agreement among raft nodes before linearized reading' (duration: 100.382505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:24.122407Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49372","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.161520Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49392","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.190494Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49406","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.295435Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49418","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.312719Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49432","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.338873Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49436","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.356885Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49468","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.396440Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49498","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.426439Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49502","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.462385Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49514","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.510495Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49542","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.530023Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49566","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.548801Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49574","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:24.562061Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49602","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:27.233585Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:49606","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-15T17:55:29.432289Z","caller":"traceutil/trace.go:172","msg":"trace[317704916] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"114.312524ms","start":"2026-04-15T17:55:29.317950Z","end":"2026-04-15T17:55:29.432262Z","steps":["trace[317704916] 'process raft request' (duration: 114.095292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:29.589515Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.209626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" limit:1 ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-04-15T17:55:29.589626Z","caller":"traceutil/trace.go:172","msg":"trace[1974949585] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:736; }","duration":"101.911453ms","start":"2026-04-15T17:55:29.487694Z","end":"2026-04-15T17:55:29.589605Z","steps":["trace[1974949585] 'range keys from in-memory index tree' (duration: 100.997453ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:29.760179Z","caller":"traceutil/trace.go:172","msg":"trace[719083559] linearizableReadLoop","detail":"{readStateIndex:769; appliedIndex:769; }","duration":"210.931611ms","start":"2026-04-15T17:55:29.549208Z","end":"2026-04-15T17:55:29.760139Z","steps":["trace[719083559] 'read index received' (duration: 210.917071ms)","trace[719083559] 'applied index is now lower than readState.Index' (duration: 11.9µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:29.760455Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"211.170684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:29.760524Z","caller":"traceutil/trace.go:172","msg":"trace[828514461] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:736; }","duration":"211.320745ms","start":"2026-04-15T17:55:29.549189Z","end":"2026-04-15T17:55:29.760510Z","steps":["trace[828514461] 'agreement among raft nodes before linearized reading' (duration: 211.061762ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:29.761400Z","caller":"traceutil/trace.go:172","msg":"trace[2039170013] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"221.978368ms","start":"2026-04-15T17:55:29.539381Z","end":"2026-04-15T17:55:29.761360Z","steps":["trace[2039170013] 'process raft request' (duration: 221.271201ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:29.932894Z","caller":"traceutil/trace.go:172","msg":"trace[323450201] linearizableReadLoop","detail":"{readStateIndex:770; appliedIndex:770; }","duration":"172.517393ms","start":"2026-04-15T17:55:29.760291Z","end":"2026-04-15T17:55:29.932809Z","steps":["trace[323450201] 'read index received' (duration: 172.494422ms)","trace[323450201] 'applied index is now lower than readState.Index' (duration: 19.631µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:29.933036Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"343.132455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T17:55:29.933114Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"343.60534ms","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-15T17:55:29.933143Z","caller":"traceutil/trace.go:172","msg":"trace[128725735] range","detail":"{range_begin:/registry/configmaps; range_end:; response_count:0; response_revision:737; }","duration":"343.280607ms","start":"2026-04-15T17:55:29.589840Z","end":"2026-04-15T17:55:29.933120Z","steps":["trace[128725735] 'agreement among raft nodes before linearized reading' (duration: 342.993854ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:29.933202Z","caller":"traceutil/trace.go:172","msg":"trace[427416276] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:737; }","duration":"343.713862ms","start":"2026-04-15T17:55:29.589469Z","end":"2026-04-15T17:55:29.933183Z","steps":["trace[427416276] 'agreement among raft nodes before linearized reading' (duration: 343.53435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:29.933652Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:29.589792Z","time spent":"343.795893ms","remote":"127.0.0.1:34336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps\" limit:1 "} {"level":"info","ts":"2026-04-15T17:55:29.934329Z","caller":"traceutil/trace.go:172","msg":"trace[1156693209] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"215.603241ms","start":"2026-04-15T17:55:29.718362Z","end":"2026-04-15T17:55:29.933966Z","steps":["trace[1156693209] 'process raft request' (duration: 214.677411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:29.940139Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"178.069992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:55:29.940256Z","caller":"traceutil/trace.go:172","msg":"trace[1651176794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:738; }","duration":"178.193933ms","start":"2026-04-15T17:55:29.762039Z","end":"2026-04-15T17:55:29.940233Z","steps":["trace[1651176794] 'agreement among raft nodes before linearized reading' (duration: 177.987061ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:29.940492Z","caller":"traceutil/trace.go:172","msg":"trace[446199143] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"158.910469ms","start":"2026-04-15T17:55:29.781564Z","end":"2026-04-15T17:55:29.940475Z","steps":["trace[446199143] 'process raft request' (duration: 158.648656ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:29.940595Z","caller":"traceutil/trace.go:172","msg":"trace[532976892] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"154.075287ms","start":"2026-04-15T17:55:29.786501Z","end":"2026-04-15T17:55:29.940576Z","steps":["trace[532976892] 'process raft request' (duration: 153.851885ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:55:29.945865Z","caller":"traceutil/trace.go:172","msg":"trace[953060213] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"102.944494ms","start":"2026-04-15T17:55:29.842877Z","end":"2026-04-15T17:55:29.945822Z","steps":["trace[953060213] 'process raft request' (duration: 98.258304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:30.973506Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59008","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:30.988374Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59024","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:31.087060Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59040","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:31.118030Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59062","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:31.273264Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59082","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:31.870410Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59110","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-15T17:55:40.463624Z","caller":"traceutil/trace.go:172","msg":"trace[1496719552] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:839; }","duration":"464.869387ms","start":"2026-04-15T17:55:39.998712Z","end":"2026-04-15T17:55:40.463581Z","steps":["trace[1496719552] 'read index received' (duration: 464.848897ms)","trace[1496719552] 'applied index is now lower than readState.Index' (duration: 17.32µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:55:40.463923Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"465.18543ms","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-15T17:55:40.464021Z","caller":"traceutil/trace.go:172","msg":"trace[1029266766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:803; }","duration":"465.308411ms","start":"2026-04-15T17:55:39.998693Z","end":"2026-04-15T17:55:40.464002Z","steps":["trace[1029266766] 'agreement among raft nodes before linearized reading' (duration: 465.003118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:40.464075Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:39.998652Z","time spent":"465.411032ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"info","ts":"2026-04-15T17:55:40.464626Z","caller":"traceutil/trace.go:172","msg":"trace[180399603] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"657.377148ms","start":"2026-04-15T17:55:39.807231Z","end":"2026-04-15T17:55:40.464608Z","steps":["trace[180399603] 'process raft request' (duration: 656.411458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:40.464821Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:39.807197Z","time spent":"657.474648ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4547,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:55:40.465484Z","caller":"traceutil/trace.go:172","msg":"trace[1183401655] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"471.357854ms","start":"2026-04-15T17:55:39.994083Z","end":"2026-04-15T17:55:40.465440Z","steps":["trace[1183401655] 'process raft request' (duration: 470.478895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:40.465620Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:39.994047Z","time spent":"471.500037ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T17:55:40.466970Z","caller":"traceutil/trace.go:172","msg":"trace[887101214] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"472.79438ms","start":"2026-04-15T17:55:39.994141Z","end":"2026-04-15T17:55:40.466935Z","steps":["trace[887101214] 'process raft request' (duration: 471.196013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:55:40.467474Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-15T17:55:39.994104Z","time spent":"473.248934ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T17:55:55.571445Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43428","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:55.592028Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43440","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:55.606027Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43452","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-15T17:55:55.621616Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43464","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-15T17:56:58.916646Z","caller":"traceutil/trace.go:172","msg":"trace[2127030185] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"105.578512ms","start":"2026-04-15T17:56:58.811041Z","end":"2026-04-15T17:56:58.916619Z","steps":["trace[2127030185] 'process raft request' (duration: 105.50642ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:56:58.916704Z","caller":"traceutil/trace.go:172","msg":"trace[299620426] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"133.12651ms","start":"2026-04-15T17:56:58.783524Z","end":"2026-04-15T17:56:58.916651Z","steps":["trace[299620426] 'process raft request' (duration: 132.891523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:57:35.238491Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"108.580739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:public-info-viewer\" limit:1 ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-04-15T17:57:35.238610Z","caller":"traceutil/trace.go:172","msg":"trace[1994989995] range","detail":"{range_begin:/registry/clusterrolebindings/system:public-info-viewer; range_end:; response_count:1; response_revision:1119; }","duration":"108.710383ms","start":"2026-04-15T17:57:35.129872Z","end":"2026-04-15T17:57:35.238583Z","steps":["trace[1994989995] 'agreement among raft nodes before linearized reading' (duration: 60.470574ms)","trace[1994989995] 'range keys from in-memory index tree' (duration: 47.963921ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:57:35.238963Z","caller":"traceutil/trace.go:172","msg":"trace[210140562] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"128.650921ms","start":"2026-04-15T17:57:35.110289Z","end":"2026-04-15T17:57:35.238940Z","steps":["trace[210140562] 'process raft request' (duration: 80.137787ms)","trace[210140562] 'compare' (duration: 48.203037ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T17:57:35.239175Z","caller":"traceutil/trace.go:172","msg":"trace[1856167942] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"128.527718ms","start":"2026-04-15T17:57:35.110637Z","end":"2026-04-15T17:57:35.239165Z","steps":["trace[1856167942] 'process raft request' (duration: 128.246961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T17:57:35.496920Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"156.703534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:volume-scheduler\" limit:1 ","response":"range_response_count:1 size:715"} {"level":"info","ts":"2026-04-15T17:57:35.497032Z","caller":"traceutil/trace.go:172","msg":"trace[1011503080] range","detail":"{range_begin:/registry/clusterrolebindings/system:volume-scheduler; range_end:; response_count:1; response_revision:1121; }","duration":"156.828647ms","start":"2026-04-15T17:57:35.340184Z","end":"2026-04-15T17:57:35.497013Z","steps":["trace[1011503080] 'range keys from in-memory index tree' (duration: 156.572211ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:57:35.740178Z","caller":"traceutil/trace.go:172","msg":"trace[2027958036] linearizableReadLoop","detail":"{readStateIndex:1180; appliedIndex:1180; }","duration":"230.224755ms","start":"2026-04-15T17:57:35.509915Z","end":"2026-04-15T17:57:35.740140Z","steps":["trace[2027958036] 'read index received' (duration: 230.211705ms)","trace[2027958036] 'applied index is now lower than readState.Index' (duration: 11.02µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T17:57:35.740411Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"230.464071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T17:57:35.740486Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"211.288451ms","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-15T17:57:35.740625Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"164.707404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:volume-scheduler\" limit:1 ","response":"range_response_count:1 size:715"} {"level":"warn","ts":"2026-04-15T17:57:35.740640Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"191.039924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T17:57:35.740623Z","caller":"traceutil/trace.go:172","msg":"trace[795658176] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1122; }","duration":"211.497136ms","start":"2026-04-15T17:57:35.529111Z","end":"2026-04-15T17:57:35.740608Z","steps":["trace[795658176] 'agreement among raft nodes before linearized reading' (duration: 211.243109ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:57:35.740701Z","caller":"traceutil/trace.go:172","msg":"trace[1155765731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1122; }","duration":"191.121086ms","start":"2026-04-15T17:57:35.549568Z","end":"2026-04-15T17:57:35.740689Z","steps":["trace[1155765731] 'agreement among raft nodes before linearized reading' (duration: 191.004303ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:57:35.740698Z","caller":"traceutil/trace.go:172","msg":"trace[319686403] range","detail":"{range_begin:/registry/clusterrolebindings/system:volume-scheduler; range_end:; response_count:1; response_revision:1122; }","duration":"164.779215ms","start":"2026-04-15T17:57:35.575897Z","end":"2026-04-15T17:57:35.740676Z","steps":["trace[319686403] 'agreement among raft nodes before linearized reading' (duration: 164.507519ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:57:35.740405Z","caller":"traceutil/trace.go:172","msg":"trace[626679888] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"233.327273ms","start":"2026-04-15T17:57:35.507009Z","end":"2026-04-15T17:57:35.740337Z","steps":["trace[626679888] 'process raft request' (duration: 233.173489ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T17:57:35.740528Z","caller":"traceutil/trace.go:172","msg":"trace[1982240436] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:1122; }","duration":"230.601824ms","start":"2026-04-15T17:57:35.509908Z","end":"2026-04-15T17:57:35.740510Z","steps":["trace[1982240436] 'agreement among raft nodes before linearized reading' (duration: 230.396859ms)"],"step_count":1}