{"level":"warn","ts":"2026-04-13T15:04:02.360249Z","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-13T15:04:02.361981Z","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-13T15:04:02.362044Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.204.45.49:2380","--initial-cluster=controller=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49: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-13T15:04:02.362266Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-04-13T15:04:02.362380Z","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-13T15:04:02.362455Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-04-13T15:04:02.362559Z","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-13T15:04:02.363147Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]} {"level":"info","ts":"2026-04-13T15:04:02.363339Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.204.45.49: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-13T15:04:02.364237Z","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: 0xc000128170}"} {"level":"info","ts":"2026-04-13T15:04:02.369215Z","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-13T15:04:02.369273Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.171516ms"} {"level":"info","ts":"2026-04-13T15:04:02.369303Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-04-13T15:04:02.369325Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-04-13T15:04:02.369368Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-04-13T15:04:02.377079Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-04-13T15:04:02.377185Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"} {"level":"info","ts":"2026-04-13T15:04:02.377209Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-04-13T15:04:02.377287Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T15:04:02.377333Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"d0ba3c4de8c6ef7a became follower at term 0"} {"level":"info","ts":"2026-04-13T15:04:02.377348Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T15:04:02.377366Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"d0ba3c4de8c6ef7a became follower at term 1"} {"level":"info","ts":"2026-04-13T15:04:02.377402Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"warn","ts":"2026-04-13T15:04:02.382914Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T15:04:02.385376Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T15:04:02.387704Z","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-13T15:04:02.388219Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T15:04:02.388446Z","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-13T15:04:02.388416Z","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-13T15:04:02.388641Z","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-13T15:04:02.388825Z","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-13T15:04:02.388821Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T15:04:02.388570Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-04-13T15:04:02.389046Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T15:04:02.388966Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T15:04:02.389059Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-04-13T15:04:02.389288Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"info","ts":"2026-04-13T15:04:02.389459Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-04-13T15:04:03.177818Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T15:04:03.177894Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T15:04:03.178007Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"} {"level":"info","ts":"2026-04-13T15:04:03.178041Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"d0ba3c4de8c6ef7a has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-13T15:04:03.178070Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"d0ba3c4de8c6ef7a became candidate at term 2"} {"level":"info","ts":"2026-04-13T15:04:03.179224Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-04-13T15:04:03.179290Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"d0ba3c4de8c6ef7a has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-13T15:04:03.179317Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"d0ba3c4de8c6ef7a became leader at term 2"} {"level":"info","ts":"2026-04-13T15:04:03.179331Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-04-13T15:04:03.180390Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-04-13T15:04:03.182136Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.6"} {"level":"info","ts":"2026-04-13T15:04:03.182270Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-04-13T15:04:03.182325Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-04-13T15:04:03.182333Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:controller ClientURLs:[https://199.204.45.49:2379]}","cluster-id":"e76701b877f442ac","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T15:04:03.182361Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T15:04:03.182450Z","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-13T15:04:03.182541Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T15:04:03.182728Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-04-13T15:04:03.183548Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T15:04:03.183716Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T15:04:03.185111Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-04-13T15:04:03.185540Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-04-13T15:04:03.185625Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-13T15:04:03.193634Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"} {"level":"info","ts":"2026-04-13T15:04:03.195198Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-13T15:04:03.195455Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50410","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.195548Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50416","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.205416Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50462","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.222455Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50494","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.236708Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50514","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.243122Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50518","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.251052Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50542","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.262103Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50554","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.273005Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50578","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.287972Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50600","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.307211Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50618","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.316762Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50632","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.325971Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50648","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.345952Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50666","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.373673Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50672","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.383872Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50680","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.401076Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50718","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.410590Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50744","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.421329Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50758","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.449235Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50794","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.460227Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50822","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.472928Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50834","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.482224Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50850","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.493388Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50862","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.504905Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50872","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.514795Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50896","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.524645Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50918","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.543089Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50936","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.548968Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50976","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.555511Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:50992","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.564779Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51018","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.573986Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51048","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.586553Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51066","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.596595Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51086","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.603005Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51102","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.619778Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51120","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.623748Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51142","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.630138Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51160","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.640972Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51184","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.648933Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51220","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.655472Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51234","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.661456Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51242","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.668672Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51260","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.678081Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51274","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.691400Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51294","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.704784Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51318","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.718574Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51334","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.727044Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51346","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.736972Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51356","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.753993Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51392","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.761275Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51400","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.770591Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51412","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.780623Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51422","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.789058Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51438","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.798589Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51448","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.835970Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51456","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.854053Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51480","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.860962Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51492","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:04:03.918406Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:51524","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-13T15:04:14.162429Z","caller":"traceutil/trace.go:172","msg":"trace[1758030323] linearizableReadLoop","detail":"{readStateIndex:345; appliedIndex:345; }","duration":"135.855952ms","start":"2026-04-13T15:04:14.026531Z","end":"2026-04-13T15:04:14.162387Z","steps":["trace[1758030323] 'read index received' (duration: 135.833222ms)","trace[1758030323] 'applied index is now lower than readState.Index' (duration: 21.03µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:14.178404Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"151.81479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-13T15:04:14.178515Z","caller":"traceutil/trace.go:172","msg":"trace[859955625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:330; }","duration":"151.962581ms","start":"2026-04-13T15:04:14.026526Z","end":"2026-04-13T15:04:14.178489Z","steps":["trace[859955625] 'agreement among raft nodes before linearized reading' (duration: 136.040312ms)","trace[859955625] 'range keys from in-memory index tree' (duration: 15.673528ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:14.178528Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"129.772045ms","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-13T15:04:14.178597Z","caller":"traceutil/trace.go:172","msg":"trace[34894525] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:331; }","duration":"129.857585ms","start":"2026-04-13T15:04:14.048723Z","end":"2026-04-13T15:04:14.178580Z","steps":["trace[34894525] 'agreement among raft nodes before linearized reading' (duration: 129.678974ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:14.178855Z","caller":"traceutil/trace.go:172","msg":"trace[1971501716] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"154.901649ms","start":"2026-04-13T15:04:14.023794Z","end":"2026-04-13T15:04:14.178695Z","steps":["trace[1971501716] 'process raft request' (duration: 138.66685ms)","trace[1971501716] 'compare' (duration: 15.822758ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:16.607873Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215511,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:04:17.108607Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215511,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:04:17.609130Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215511,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:04:18.109716Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215511,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:04:18.610457Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215511,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:04:18.667698Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.844223216s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T15:04:18.667982Z","caller":"traceutil/trace.go:172","msg":"trace[975778458] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:387; }","duration":"2.560866886s","start":"2026-04-13T15:04:16.107064Z","end":"2026-04-13T15:04:18.667931Z","steps":["trace[975778458] 'read index received' (duration: 2.560856226s)","trace[975778458] 'applied index is now lower than readState.Index' (duration: 9.3µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:18.668206Z","caller":"traceutil/trace.go:172","msg":"trace[2127156512] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"2.844830161s","start":"2026-04-13T15:04:15.823359Z","end":"2026-04-13T15:04:18.668190Z","steps":["trace[2127156512] 'process raft request' (duration: 2.844664349s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:18.668764Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.561687603s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.49\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-13T15:04:18.668814Z","caller":"traceutil/trace.go:172","msg":"trace[37308151] range","detail":"{range_begin:/registry/masterleases/199.204.45.49; range_end:; response_count:1; response_revision:371; }","duration":"2.561745263s","start":"2026-04-13T15:04:16.107058Z","end":"2026-04-13T15:04:18.668803Z","steps":["trace[37308151] 'agreement among raft nodes before linearized reading' (duration: 2.560979507s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:18.668842Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:16.107032Z","time spent":"2.561801734s","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.49\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:18.668997Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:15.823344Z","time spent":"2.844909651s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5024,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:19.169179Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215516,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T15:04:19.629403Z","caller":"traceutil/trace.go:172","msg":"trace[1592130159] linearizableReadLoop","detail":"{readStateIndex:388; appliedIndex:388; }","duration":"961.150029ms","start":"2026-04-13T15:04:18.668218Z","end":"2026-04-13T15:04:19.629368Z","steps":["trace[1592130159] 'read index received' (duration: 961.135639ms)","trace[1592130159] 'applied index is now lower than readState.Index' (duration: 11.9µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:19.633352Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.142390809s","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-13T15:04:19.633411Z","caller":"traceutil/trace.go:172","msg":"trace[372670617] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:372; }","duration":"3.14245618s","start":"2026-04-13T15:04:16.490941Z","end":"2026-04-13T15:04:19.633397Z","steps":["trace[372670617] 'agreement among raft nodes before linearized reading' (duration: 3.138495906s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:19.633400Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.067722232s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T15:04:19.633492Z","caller":"traceutil/trace.go:172","msg":"trace[310397319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:372; }","duration":"3.067826372s","start":"2026-04-13T15:04:16.565641Z","end":"2026-04-13T15:04:19.633468Z","steps":["trace[310397319] 'agreement among raft nodes before linearized reading' (duration: 3.063755438s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:19.633534Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:16.565628Z","time spent":"3.067896763s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:19.633695Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.432647575s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-13T15:04:19.633759Z","caller":"traceutil/trace.go:172","msg":"trace[764676110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:372; }","duration":"3.432719416s","start":"2026-04-13T15:04:16.201023Z","end":"2026-04-13T15:04:19.633742Z","steps":["trace[764676110] 'agreement among raft nodes before linearized reading' (duration: 3.42848562s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:19.633798Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:16.201000Z","time spent":"3.432788736s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-04-13T15:04:19.633945Z","caller":"traceutil/trace.go:172","msg":"trace[818903477] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"3.359869708s","start":"2026-04-13T15:04:16.274065Z","end":"2026-04-13T15:04:19.633934Z","steps":["trace[818903477] 'process raft request' (duration: 3.355504081s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:19.634015Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:16.274042Z","time spent":"3.359931319s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:04:19.634777Z","caller":"traceutil/trace.go:172","msg":"trace[832108271] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"2.726626011s","start":"2026-04-13T15:04:16.908134Z","end":"2026-04-13T15:04:19.634760Z","steps":["trace[832108271] 'process raft request' (duration: 2.725622152s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:19.634882Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:16.908113Z","time spent":"2.726712082s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:04:19.634776Z","caller":"traceutil/trace.go:172","msg":"trace[1482714323] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"1.761403889s","start":"2026-04-13T15:04:17.873348Z","end":"2026-04-13T15:04:19.634752Z","steps":["trace[1482714323] 'process raft request' (duration: 1.760970155s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:19.635422Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:17.873321Z","time spent":"1.762040754s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:19.636815Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"168.708296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:04:19.636902Z","caller":"traceutil/trace.go:172","msg":"trace[658803078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:375; }","duration":"168.793227ms","start":"2026-04-13T15:04:19.468091Z","end":"2026-04-13T15:04:19.636884Z","steps":["trace[658803078] 'agreement among raft nodes before linearized reading' (duration: 168.679686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:19.637213Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"963.099062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 ","response":"range_response_count:1 size:4943"} {"level":"info","ts":"2026-04-13T15:04:19.637258Z","caller":"traceutil/trace.go:172","msg":"trace[1446885105] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-controller; range_end:; response_count:1; response_revision:375; }","duration":"963.143633ms","start":"2026-04-13T15:04:18.674101Z","end":"2026-04-13T15:04:19.637245Z","steps":["trace[1446885105] 'agreement among raft nodes before linearized reading' (duration: 962.999962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:19.637287Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:18.674081Z","time spent":"963.197073ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":4967,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-controller\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:19.638252Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:18.670822Z","time spent":"967.427017ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-13T15:04:19.638289Z","caller":"traceutil/trace.go:172","msg":"trace[1742863585] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"964.218692ms","start":"2026-04-13T15:04:18.674057Z","end":"2026-04-13T15:04:19.638275Z","steps":["trace[1742863585] 'process raft request' (duration: 964.041811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:19.638392Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:18.674023Z","time spent":"964.292103ms","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2880,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:04:19.754503Z","caller":"traceutil/trace.go:172","msg":"trace[1582898922] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:394; }","duration":"105.899805ms","start":"2026-04-13T15:04:19.648572Z","end":"2026-04-13T15:04:19.754472Z","steps":["trace[1582898922] 'read index received' (duration: 105.879215ms)","trace[1582898922] 'applied index is now lower than readState.Index' (duration: 19.02µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:19.867218Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"218.626818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" limit:1 ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-04-13T15:04:19.867344Z","caller":"traceutil/trace.go:172","msg":"trace[1044672607] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:377; }","duration":"218.756979ms","start":"2026-04-13T15:04:19.648562Z","end":"2026-04-13T15:04:19.867319Z","steps":["trace[1044672607] 'agreement among raft nodes before linearized reading' (duration: 106.008416ms)","trace[1044672607] 'range keys from in-memory index tree' (duration: 112.48909ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:19.868399Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"112.956775ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:04:19.868656Z","caller":"traceutil/trace.go:172","msg":"trace[1497467165] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"227.537043ms","start":"2026-04-13T15:04:19.641052Z","end":"2026-04-13T15:04:19.868590Z","steps":["trace[1497467165] 'process raft request' (duration: 113.451589ms)","trace[1497467165] 'compare' (duration: 112.47668ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:19.868846Z","caller":"traceutil/trace.go:172","msg":"trace[365370463] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"223.65448ms","start":"2026-04-13T15:04:19.645170Z","end":"2026-04-13T15:04:19.868825Z","steps":["trace[365370463] 'process raft request' (duration: 223.379398ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:19.869036Z","caller":"traceutil/trace.go:172","msg":"trace[755159200] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"226.181432ms","start":"2026-04-13T15:04:19.642676Z","end":"2026-04-13T15:04:19.868857Z","steps":["trace[755159200] 'process raft request' (duration: 225.792438ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:20.422468Z","caller":"traceutil/trace.go:172","msg":"trace[1955898819] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"408.355869ms","start":"2026-04-13T15:04:20.014091Z","end":"2026-04-13T15:04:20.422447Z","steps":["trace[1955898819] 'process raft request' (duration: 323.446226ms)","trace[1955898819] 'compare' (duration: 84.638091ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:20.422572Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:20.014068Z","time spent":"408.45393ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5757,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:26.186487Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215565,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T15:04:26.556478Z","caller":"traceutil/trace.go:172","msg":"trace[1925872000] linearizableReadLoop","detail":"{readStateIndex:412; appliedIndex:412; }","duration":"870.553827ms","start":"2026-04-13T15:04:25.685895Z","end":"2026-04-13T15:04:26.556449Z","steps":["trace[1925872000] 'read index received' (duration: 870.541437ms)","trace[1925872000] 'applied index is now lower than readState.Index' (duration: 10.33µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:26.803393Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.117478297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" limit:1 ","response":"range_response_count:1 size:4338"} {"level":"info","ts":"2026-04-13T15:04:26.803475Z","caller":"traceutil/trace.go:172","msg":"trace[1052753166] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:394; }","duration":"1.117568129s","start":"2026-04-13T15:04:25.685886Z","end":"2026-04-13T15:04:26.803454Z","steps":["trace[1052753166] 'agreement among raft nodes before linearized reading' (duration: 870.701279ms)","trace[1052753166] 'range keys from in-memory index tree' (duration: 246.590904ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:26.803516Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:25.685866Z","time spent":"1.11763723s","remote":"127.0.0.1:51304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4362,"request content":"key:\"/registry/deployments/kube-system/coredns\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:26.803502Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.167257193s","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-13T15:04:26.803562Z","caller":"traceutil/trace.go:172","msg":"trace[594508147] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:394; }","duration":"1.167324214s","start":"2026-04-13T15:04:25.636222Z","end":"2026-04-13T15:04:26.803546Z","steps":["trace[594508147] 'range keys from in-memory index tree' (duration: 1.167194093s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:26.804914Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"247.975446ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:04:26.805521Z","caller":"traceutil/trace.go:172","msg":"trace[398456225] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"1.134996328s","start":"2026-04-13T15:04:25.670504Z","end":"2026-04-13T15:04:26.805500Z","steps":["trace[398456225] 'process raft request' (duration: 1.134852786s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:26.805829Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"905.035039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T15:04:26.805903Z","caller":"traceutil/trace.go:172","msg":"trace[1062957058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:396; }","duration":"905.13071ms","start":"2026-04-13T15:04:25.900757Z","end":"2026-04-13T15:04:26.805888Z","steps":["trace[1062957058] 'agreement among raft nodes before linearized reading' (duration: 904.796885ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:26.805528Z","caller":"traceutil/trace.go:172","msg":"trace[465486156] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:412; }","duration":"248.911511ms","start":"2026-04-13T15:04:26.556553Z","end":"2026-04-13T15:04:26.805465Z","steps":["trace[465486156] 'read index received' (duration: 57.971µs)","trace[465486156] 'applied index is now lower than readState.Index' (duration: 248.85251ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:26.805611Z","caller":"traceutil/trace.go:172","msg":"trace[2078290023] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"1.135069329s","start":"2026-04-13T15:04:25.670504Z","end":"2026-04-13T15:04:26.805573Z","steps":["trace[2078290023] 'process raft request' (duration: 885.988876ms)","trace[2078290023] 'compare' (duration: 247.356847ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:26.805599Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.0357453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:04:26.806328Z","caller":"traceutil/trace.go:172","msg":"trace[2078760127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:396; }","duration":"1.036476302s","start":"2026-04-13T15:04:25.769841Z","end":"2026-04-13T15:04:26.806317Z","steps":["trace[2078760127] 'agreement among raft nodes before linearized reading' (duration: 1.035717479s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:26.806366Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:25.769806Z","time spent":"1.036551043s","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T15:04:26.806327Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:25.670471Z","time spent":"1.135762311s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:26.805701Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"905.088499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-13T15:04:26.806552Z","caller":"traceutil/trace.go:172","msg":"trace[1401613946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:396; }","duration":"905.936513ms","start":"2026-04-13T15:04:25.900596Z","end":"2026-04-13T15:04:26.806533Z","steps":["trace[1401613946] 'agreement among raft nodes before linearized reading' (duration: 905.000218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:26.806707Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:25.900544Z","time spent":"906.142387ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:26.805741Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"698.639077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.49\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-13T15:04:26.805977Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:25.900748Z","time spent":"905.219081ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:26.806135Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:25.670468Z","time spent":"1.135370513s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:04:26.806873Z","caller":"traceutil/trace.go:172","msg":"trace[490276508] range","detail":"{range_begin:/registry/masterleases/199.204.45.49; range_end:; response_count:1; response_revision:396; }","duration":"699.763075ms","start":"2026-04-13T15:04:26.107085Z","end":"2026-04-13T15:04:26.806848Z","steps":["trace[490276508] 'agreement among raft nodes before linearized reading' (duration: 698.550225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:26.807602Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:26.107063Z","time spent":"700.518716ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.49\" limit:1 "} {"level":"info","ts":"2026-04-13T15:04:26.997861Z","caller":"traceutil/trace.go:172","msg":"trace[770186276] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:414; }","duration":"178.31178ms","start":"2026-04-13T15:04:26.819522Z","end":"2026-04-13T15:04:26.997834Z","steps":["trace[770186276] 'read index received' (duration: 178.30131ms)","trace[770186276] 'applied index is now lower than readState.Index' (duration: 9.03µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:27.066306Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"246.755968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:04:27.066381Z","caller":"traceutil/trace.go:172","msg":"trace[1935549043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:396; }","duration":"246.8457ms","start":"2026-04-13T15:04:26.819518Z","end":"2026-04-13T15:04:27.066364Z","steps":["trace[1935549043] 'agreement among raft nodes before linearized reading' (duration: 178.411701ms)","trace[1935549043] 'range keys from in-memory index tree' (duration: 68.315416ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:27.069389Z","caller":"traceutil/trace.go:172","msg":"trace[1470432997] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"244.72162ms","start":"2026-04-13T15:04:26.824649Z","end":"2026-04-13T15:04:27.069370Z","steps":["trace[1470432997] 'process raft request' (duration: 244.686478ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:27.069513Z","caller":"traceutil/trace.go:172","msg":"trace[1557531457] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"256.557546ms","start":"2026-04-13T15:04:26.812945Z","end":"2026-04-13T15:04:27.069502Z","steps":["trace[1557531457] 'process raft request' (duration: 256.348952ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:27.069682Z","caller":"traceutil/trace.go:172","msg":"trace[2058166018] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"256.842531ms","start":"2026-04-13T15:04:26.812823Z","end":"2026-04-13T15:04:27.069665Z","steps":["trace[2058166018] 'process raft request' (duration: 256.351522ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:27.217736Z","caller":"traceutil/trace.go:172","msg":"trace[1943514213] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:419; }","duration":"117.466812ms","start":"2026-04-13T15:04:27.100248Z","end":"2026-04-13T15:04:27.217715Z","steps":["trace[1943514213] 'read index received' (duration: 117.459812ms)","trace[1943514213] 'applied index is now lower than readState.Index' (duration: 5.98µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:27.244446Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"144.184079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" limit:1 ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-04-13T15:04:27.244546Z","caller":"traceutil/trace.go:172","msg":"trace[815476798] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:400; }","duration":"144.290231ms","start":"2026-04-13T15:04:27.100226Z","end":"2026-04-13T15:04:27.244516Z","steps":["trace[815476798] 'agreement among raft nodes before linearized reading' (duration: 117.695257ms)","trace[815476798] 'range keys from in-memory index tree' (duration: 26.380181ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:27.244827Z","caller":"traceutil/trace.go:172","msg":"trace[1152206190] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"167.5305ms","start":"2026-04-13T15:04:27.077275Z","end":"2026-04-13T15:04:27.244805Z","steps":["trace[1152206190] 'process raft request' (duration: 140.638921ms)","trace[1152206190] 'compare' (duration: 26.760837ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:27.401794Z","caller":"traceutil/trace.go:172","msg":"trace[2120239210] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"147.628228ms","start":"2026-04-13T15:04:27.254152Z","end":"2026-04-13T15:04:27.401780Z","steps":["trace[2120239210] 'process raft request' (duration: 147.569487ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:27.401857Z","caller":"traceutil/trace.go:172","msg":"trace[1069849043] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"150.032457ms","start":"2026-04-13T15:04:27.251802Z","end":"2026-04-13T15:04:27.401834Z","steps":["trace[1069849043] 'process raft request' (duration: 139.549931ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:27.745827Z","caller":"traceutil/trace.go:172","msg":"trace[619552752] linearizableReadLoop","detail":"{readStateIndex:432; appliedIndex:432; }","duration":"262.067339ms","start":"2026-04-13T15:04:27.483711Z","end":"2026-04-13T15:04:27.745778Z","steps":["trace[619552752] 'read index received' (duration: 262.042399ms)","trace[619552752] 'applied index is now lower than readState.Index' (duration: 22.28µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:28.005767Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"522.009566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7488bc8bd5\" limit:1 ","response":"range_response_count:1 size:4137"} {"level":"info","ts":"2026-04-13T15:04:28.005853Z","caller":"traceutil/trace.go:172","msg":"trace[1802496138] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7488bc8bd5; range_end:; response_count:1; response_revision:413; }","duration":"522.141589ms","start":"2026-04-13T15:04:27.483691Z","end":"2026-04-13T15:04:28.005833Z","steps":["trace[1802496138] 'agreement among raft nodes before linearized reading' (duration: 262.227673ms)","trace[1802496138] 'range keys from in-memory index tree' (duration: 259.715512ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:28.005895Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:27.483675Z","time spent":"522.21003ms","remote":"127.0.0.1:51360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":4161,"request content":"key:\"/registry/replicasets/kube-system/coredns-7488bc8bd5\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:28.005933Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"260.028238ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:4148"} {"level":"info","ts":"2026-04-13T15:04:28.006034Z","caller":"traceutil/trace.go:172","msg":"trace[2096827496] transaction","detail":"{read_only:false; number_of_response:1; response_revision:413; }","duration":"530.297084ms","start":"2026-04-13T15:04:27.475717Z","end":"2026-04-13T15:04:28.006014Z","steps":["trace[2096827496] 'process raft request' (duration: 270.126923ms)","trace[2096827496] 'compare' (duration: 259.957587ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:28.006109Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:27.475679Z","time spent":"530.395876ms","remote":"127.0.0.1:51360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":56,"response count":0,"response size":4172,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:28.005768Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"370.200249ms","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-13T15:04:28.006191Z","caller":"traceutil/trace.go:172","msg":"trace[1210547057] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:413; }","duration":"370.654497ms","start":"2026-04-13T15:04:27.635520Z","end":"2026-04-13T15:04:28.006175Z","steps":["trace[1210547057] 'range keys from in-memory index tree' (duration: 370.087496ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:28.152907Z","caller":"traceutil/trace.go:172","msg":"trace[2116407564] linearizableReadLoop","detail":"{readStateIndex:433; appliedIndex:433; }","duration":"146.567507ms","start":"2026-04-13T15:04:28.006261Z","end":"2026-04-13T15:04:28.152828Z","steps":["trace[2116407564] 'read index received' (duration: 146.549267ms)","trace[2116407564] 'applied index is now lower than readState.Index' (duration: 16.1µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:28.153061Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"146.78147ms","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-13T15:04:28.153090Z","caller":"traceutil/trace.go:172","msg":"trace[909509397] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:413; }","duration":"146.828601ms","start":"2026-04-13T15:04:28.006252Z","end":"2026-04-13T15:04:28.153080Z","steps":["trace[909509397] 'agreement among raft nodes before linearized reading' (duration: 146.75128ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:28.153270Z","caller":"traceutil/trace.go:172","msg":"trace[1853469134] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"668.331579ms","start":"2026-04-13T15:04:27.484917Z","end":"2026-04-13T15:04:28.153249Z","steps":["trace[1853469134] 'process raft request' (duration: 668.251798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:28.153419Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:27.484816Z","time spent":"668.521632ms","remote":"127.0.0.1:51360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4086,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:04:28.153661Z","caller":"traceutil/trace.go:172","msg":"trace[1431124256] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"672.112553ms","start":"2026-04-13T15:04:27.481516Z","end":"2026-04-13T15:04:28.153628Z","steps":["trace[1431124256] 'process raft request' (duration: 671.524782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:28.153812Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:27.481501Z","time spent":"672.242755ms","remote":"127.0.0.1:50532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T15:04:28.298945Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"288.977721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7488bc8bd5\" limit:1 ","response":"range_response_count:1 size:4137"} {"level":"info","ts":"2026-04-13T15:04:28.299040Z","caller":"traceutil/trace.go:172","msg":"trace[1316413968] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7488bc8bd5; range_end:; response_count:1; response_revision:415; }","duration":"289.086643ms","start":"2026-04-13T15:04:28.009933Z","end":"2026-04-13T15:04:28.299020Z","steps":["trace[1316413968] 'agreement among raft nodes before linearized reading' (duration: 200.292746ms)","trace[1316413968] 'range keys from in-memory index tree' (duration: 88.538192ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:28.299533Z","caller":"traceutil/trace.go:172","msg":"trace[948278299] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"279.917191ms","start":"2026-04-13T15:04:28.019597Z","end":"2026-04-13T15:04:28.299514Z","steps":["trace[948278299] 'process raft request' (duration: 190.703066ms)","trace[948278299] 'compare' (duration: 88.38816ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:28.299821Z","caller":"traceutil/trace.go:172","msg":"trace[1944556211] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"138.294742ms","start":"2026-04-13T15:04:28.161505Z","end":"2026-04-13T15:04:28.299800Z","steps":["trace[1944556211] 'process raft request' (duration: 138.16694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:28.599687Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"133.621509ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:04:28.599810Z","caller":"traceutil/trace.go:172","msg":"trace[732348974] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"270.642268ms","start":"2026-04-13T15:04:28.329143Z","end":"2026-04-13T15:04:28.599785Z","steps":["trace[732348974] 'process raft request' (duration: 136.831076ms)","trace[732348974] 'compare' (duration: 133.423135ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:28.603345Z","caller":"traceutil/trace.go:172","msg":"trace[1705899617] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"211.34678ms","start":"2026-04-13T15:04:28.391972Z","end":"2026-04-13T15:04:28.603319Z","steps":["trace[1705899617] 'process raft request' (duration: 211.158927ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:28.603401Z","caller":"traceutil/trace.go:172","msg":"trace[1981248110] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"207.91564ms","start":"2026-04-13T15:04:28.395460Z","end":"2026-04-13T15:04:28.603375Z","steps":["trace[1981248110] 'process raft request' (duration: 207.844749ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:28.603697Z","caller":"traceutil/trace.go:172","msg":"trace[1735354209] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"212.143435ms","start":"2026-04-13T15:04:28.391535Z","end":"2026-04-13T15:04:28.603678Z","steps":["trace[1735354209] 'process raft request' (duration: 211.441953ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:28.604214Z","caller":"traceutil/trace.go:172","msg":"trace[954859181] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"211.178807ms","start":"2026-04-13T15:04:28.393017Z","end":"2026-04-13T15:04:28.604196Z","steps":["trace[954859181] 'process raft request' (duration: 210.17021ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:28.805315Z","caller":"traceutil/trace.go:172","msg":"trace[638969356] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"108.524056ms","start":"2026-04-13T15:04:28.696764Z","end":"2026-04-13T15:04:28.805288Z","steps":["trace[638969356] 'process raft request' (duration: 54.293069ms)","trace[638969356] 'compare' (duration: 54.002863ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:33.206945Z","caller":"traceutil/trace.go:172","msg":"trace[232979956] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"104.504273ms","start":"2026-04-13T15:04:33.102203Z","end":"2026-04-13T15:04:33.206707Z","steps":["trace[232979956] 'process raft request' (duration: 104.37496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:43.837365Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215771,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T15:04:43.885208Z","caller":"traceutil/trace.go:172","msg":"trace[1640528342] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:519; }","duration":"548.147689ms","start":"2026-04-13T15:04:43.337026Z","end":"2026-04-13T15:04:43.885174Z","steps":["trace[1640528342] 'read index received' (duration: 548.131079ms)","trace[1640528342] 'applied index is now lower than readState.Index' (duration: 14.78µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:44.533012Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.195962619s","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-13T15:04:44.533113Z","caller":"traceutil/trace.go:172","msg":"trace[819944226] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:496; }","duration":"1.196064672s","start":"2026-04-13T15:04:43.337021Z","end":"2026-04-13T15:04:44.533085Z","steps":["trace[819944226] 'agreement among raft nodes before linearized reading' (duration: 548.221701ms)","trace[819944226] 'range keys from in-memory index tree' (duration: 647.699846ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:44.533166Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:43.337005Z","time spent":"1.196146896s","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":29,"request content":"key:\"/registry/secrets\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:44.533380Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"890.015885ms","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-13T15:04:44.533595Z","caller":"traceutil/trace.go:172","msg":"trace[2096730387] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:496; }","duration":"890.436659ms","start":"2026-04-13T15:04:43.643099Z","end":"2026-04-13T15:04:44.533536Z","steps":["trace[2096730387] 'range keys from in-memory index tree' (duration: 889.959592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:44.533951Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"648.678707ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:04:44.534027Z","caller":"traceutil/trace.go:172","msg":"trace[552346784] linearizableReadLoop","detail":"{readStateIndex:520; appliedIndex:519; }","duration":"648.724078ms","start":"2026-04-13T15:04:43.885291Z","end":"2026-04-13T15:04:44.534016Z","steps":["trace[552346784] 'read index received' (duration: 43.501µs)","trace[552346784] 'applied index is now lower than readState.Index' (duration: 648.679287ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:44.534208Z","caller":"traceutil/trace.go:172","msg":"trace[368676279] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"1.206035634s","start":"2026-04-13T15:04:43.328145Z","end":"2026-04-13T15:04:44.534181Z","steps":["trace[368676279] 'process raft request' (duration: 557.057748ms)","trace[368676279] 'compare' (duration: 648.143771ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:44.534238Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"762.854465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:04:44.534276Z","caller":"traceutil/trace.go:172","msg":"trace[68659173] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"762.890406ms","start":"2026-04-13T15:04:43.771374Z","end":"2026-04-13T15:04:44.534264Z","steps":["trace[68659173] 'agreement among raft nodes before linearized reading' (duration: 762.831484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:44.534300Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:43.771348Z","time spent":"762.945948ms","remote":"127.0.0.1:50408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T15:04:44.534322Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:43.328114Z","time spent":"1.206151728s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:44.754734Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"118.722723ms","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-13T15:04:44.754822Z","caller":"traceutil/trace.go:172","msg":"trace[2656368] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:497; }","duration":"118.852027ms","start":"2026-04-13T15:04:44.635955Z","end":"2026-04-13T15:04:44.754807Z","steps":["trace[2656368] 'range keys from in-memory index tree' (duration: 118.706153ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:46.000370Z","caller":"traceutil/trace.go:172","msg":"trace[1940034946] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"102.207376ms","start":"2026-04-13T15:04:45.898138Z","end":"2026-04-13T15:04:46.000346Z","steps":["trace[1940034946] 'process raft request' (duration: 101.263697ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:46.490466Z","caller":"traceutil/trace.go:172","msg":"trace[369808252] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:601; }","duration":"189.786607ms","start":"2026-04-13T15:04:46.300653Z","end":"2026-04-13T15:04:46.490439Z","steps":["trace[369808252] 'read index received' (duration: 189.775126ms)","trace[369808252] 'applied index is now lower than readState.Index' (duration: 9.541µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:46.490661Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"189.988563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" limit:1 ","response":"range_response_count:1 size:18056"} {"level":"info","ts":"2026-04-13T15:04:46.490682Z","caller":"traceutil/trace.go:172","msg":"trace[1699145459] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:573; }","duration":"190.028104ms","start":"2026-04-13T15:04:46.300647Z","end":"2026-04-13T15:04:46.490675Z","steps":["trace[1699145459] 'agreement among raft nodes before linearized reading' (duration: 189.89041ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:46.491104Z","caller":"traceutil/trace.go:172","msg":"trace[472205291] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"190.655464ms","start":"2026-04-13T15:04:46.300434Z","end":"2026-04-13T15:04:46.491090Z","steps":["trace[472205291] 'process raft request' (duration: 190.343714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:46.638164Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"136.00556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" limit:1 ","response":"range_response_count:1 size:98713"} {"level":"info","ts":"2026-04-13T15:04:46.638256Z","caller":"traceutil/trace.go:172","msg":"trace[1529631371] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:574; }","duration":"136.110584ms","start":"2026-04-13T15:04:46.502124Z","end":"2026-04-13T15:04:46.638234Z","steps":["trace[1529631371] 'agreement among raft nodes before linearized reading' (duration: 85.624884ms)","trace[1529631371] 'range keys from in-memory index tree' (duration: 50.250792ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:46.638973Z","caller":"traceutil/trace.go:172","msg":"trace[1928385731] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"287.644604ms","start":"2026-04-13T15:04:46.351310Z","end":"2026-04-13T15:04:46.638954Z","steps":["trace[1928385731] 'process raft request' (duration: 236.542225ms)","trace[1928385731] 'compare' (duration: 50.307864ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:46.639375Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.448234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T15:04:46.639458Z","caller":"traceutil/trace.go:172","msg":"trace[1001118053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"101.540917ms","start":"2026-04-13T15:04:46.537900Z","end":"2026-04-13T15:04:46.639441Z","steps":["trace[1001118053] 'agreement among raft nodes before linearized reading' (duration: 101.30885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:46.925446Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"189.745194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" limit:1 ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-04-13T15:04:46.925508Z","caller":"traceutil/trace.go:172","msg":"trace[556324574] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:577; }","duration":"189.816236ms","start":"2026-04-13T15:04:46.735678Z","end":"2026-04-13T15:04:46.925494Z","steps":["trace[556324574] 'agreement among raft nodes before linearized reading' (duration: 82.916716ms)","trace[556324574] 'range keys from in-memory index tree' (duration: 106.515718ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:46.925561Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.811577ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:04:46.925674Z","caller":"traceutil/trace.go:172","msg":"trace[625041554] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"107.102738ms","start":"2026-04-13T15:04:46.818557Z","end":"2026-04-13T15:04:46.925659Z","steps":["trace[625041554] 'read index received' (duration: 29.051µs)","trace[625041554] 'applied index is now lower than readState.Index' (duration: 107.072547ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:46.925744Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"153.878217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:04:46.925771Z","caller":"traceutil/trace.go:172","msg":"trace[1271695274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"153.904998ms","start":"2026-04-13T15:04:46.771858Z","end":"2026-04-13T15:04:46.925763Z","steps":["trace[1271695274] 'agreement among raft nodes before linearized reading' (duration: 153.849986ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:46.925779Z","caller":"traceutil/trace.go:172","msg":"trace[152321420] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"192.272557ms","start":"2026-04-13T15:04:46.733478Z","end":"2026-04-13T15:04:46.925751Z","steps":["trace[152321420] 'process raft request' (duration: 85.20902ms)","trace[152321420] 'compare' (duration: 106.656193ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:51.741614Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"105.665718ms","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-13T15:04:51.741675Z","caller":"traceutil/trace.go:172","msg":"trace[1456996447] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:606; }","duration":"105.73919ms","start":"2026-04-13T15:04:51.635925Z","end":"2026-04-13T15:04:51.741664Z","steps":["trace[1456996447] 'range keys from in-memory index tree' (duration: 105.629897ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:51.789709Z","caller":"traceutil/trace.go:172","msg":"trace[1371935113] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"252.150131ms","start":"2026-04-13T15:04:51.537529Z","end":"2026-04-13T15:04:51.789679Z","steps":["trace[1371935113] 'process raft request' (duration: 251.806419ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:52.182065Z","caller":"traceutil/trace.go:172","msg":"trace[583760906] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:636; }","duration":"392.883925ms","start":"2026-04-13T15:04:51.789144Z","end":"2026-04-13T15:04:52.182028Z","steps":["trace[583760906] 'read index received' (duration: 392.874275ms)","trace[583760906] 'applied index is now lower than readState.Index' (duration: 8.49µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:52.190203Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"419.335763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:04:52.190262Z","caller":"traceutil/trace.go:172","msg":"trace[912268447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"419.397535ms","start":"2026-04-13T15:04:51.770852Z","end":"2026-04-13T15:04:52.190249Z","steps":["trace[912268447] 'agreement among raft nodes before linearized reading' (duration: 411.243989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:52.190287Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:51.770832Z","time spent":"419.449597ms","remote":"127.0.0.1:50408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T15:04:52.190507Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"269.886534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jd8gd\" limit:1 ","response":"range_response_count:1 size:18345"} {"level":"info","ts":"2026-04-13T15:04:52.190534Z","caller":"traceutil/trace.go:172","msg":"trace[1419939504] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jd8gd; range_end:; response_count:1; response_revision:608; }","duration":"269.914985ms","start":"2026-04-13T15:04:51.920613Z","end":"2026-04-13T15:04:52.190528Z","steps":["trace[1419939504] 'agreement among raft nodes before linearized reading' (duration: 269.826602ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:52.190611Z","caller":"traceutil/trace.go:172","msg":"trace[653859741] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"471.617007ms","start":"2026-04-13T15:04:51.718984Z","end":"2026-04-13T15:04:52.190601Z","steps":["trace[653859741] 'process raft request' (duration: 463.255544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:52.190688Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:51.718952Z","time spent":"471.69424ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:04:52.965275Z","caller":"traceutil/trace.go:172","msg":"trace[1651911305] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:637; }","duration":"328.995523ms","start":"2026-04-13T15:04:52.636249Z","end":"2026-04-13T15:04:52.965244Z","steps":["trace[1651911305] 'read index received' (duration: 328.985763ms)","trace[1651911305] 'applied index is now lower than readState.Index' (duration: 8.54µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:52.965461Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"329.185821ms","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-13T15:04:52.965546Z","caller":"traceutil/trace.go:172","msg":"trace[1087949222] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:608; }","duration":"329.286944ms","start":"2026-04-13T15:04:52.636242Z","end":"2026-04-13T15:04:52.965529Z","steps":["trace[1087949222] 'agreement among raft nodes before linearized reading' (duration: 329.122809ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:52.965583Z","caller":"traceutil/trace.go:172","msg":"trace[181735085] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"756.908139ms","start":"2026-04-13T15:04:52.208668Z","end":"2026-04-13T15:04:52.965576Z","steps":["trace[181735085] 'process raft request' (duration: 756.754024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:52.965663Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:52.208648Z","time spent":"756.9622ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18502,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:53.465699Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215968,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:04:53.966660Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215968,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:04:54.173641Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.208332146s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T15:04:54.173904Z","caller":"traceutil/trace.go:172","msg":"trace[349760903] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:638; }","duration":"1.208521623s","start":"2026-04-13T15:04:52.965341Z","end":"2026-04-13T15:04:54.173863Z","steps":["trace[349760903] 'read index received' (duration: 1.208507082s)","trace[349760903] 'applied index is now lower than readState.Index' (duration: 12.601µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:55.749340Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.97930872s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T15:04:55.749494Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.575409074s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:04:55.749595Z","caller":"traceutil/trace.go:172","msg":"trace[385496949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"2.979443805s","start":"2026-04-13T15:04:52.770006Z","end":"2026-04-13T15:04:55.749450Z","steps":["trace[385496949] 'agreement among raft nodes before linearized reading' (duration: 1.403957848s)","trace[385496949] 'range keys from in-memory index tree' (duration: 1.57503396s)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:55.749342Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.113913122s","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-13T15:04:55.749708Z","caller":"traceutil/trace.go:172","msg":"trace[1507165804] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"2.723041363s","start":"2026-04-13T15:04:53.026652Z","end":"2026-04-13T15:04:55.749694Z","steps":["trace[1507165804] 'process raft request' (duration: 2.723000181s)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:55.749713Z","caller":"traceutil/trace.go:172","msg":"trace[1641241097] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:609; }","duration":"2.114259135s","start":"2026-04-13T15:04:53.635410Z","end":"2026-04-13T15:04:55.749669Z","steps":["trace[1641241097] 'range keys from in-memory index tree' (duration: 2.113863821s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:55.749775Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:53.026626Z","time spent":"2.723113986s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:55.749862Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:52.769981Z","time spent":"2.979872621s","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T15:04:55.749881Z","caller":"traceutil/trace.go:172","msg":"trace[338889773] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"1.575677535s","start":"2026-04-13T15:04:54.174194Z","end":"2026-04-13T15:04:55.749871Z","steps":["trace[338889773] 'read index received' (duration: 101.649628ms)","trace[338889773] 'applied index is now lower than readState.Index' (duration: 1.474027047s)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:55.749991Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.355455796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-13T15:04:55.750469Z","caller":"traceutil/trace.go:172","msg":"trace[323131695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:612; }","duration":"2.355935454s","start":"2026-04-13T15:04:53.394527Z","end":"2026-04-13T15:04:55.750462Z","steps":["trace[323131695] 'agreement among raft nodes before linearized reading' (duration: 2.355373852s)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:55.750534Z","caller":"traceutil/trace.go:172","msg":"trace[2130567123] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"3.496206827s","start":"2026-04-13T15:04:52.254310Z","end":"2026-04-13T15:04:55.750517Z","steps":["trace[2130567123] 'process raft request' (duration: 1.919715321s)","trace[2130567123] 'compare' (duration: 1.575125793s)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:55.750491Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:53.394499Z","time spent":"2.355985236s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:55.750572Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:52.254283Z","time spent":"3.496271189s","remote":"127.0.0.1:51410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T15:04:55.750033Z","caller":"traceutil/trace.go:172","msg":"trace[845125839] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"2.795877102s","start":"2026-04-13T15:04:52.953950Z","end":"2026-04-13T15:04:55.749827Z","steps":["trace[845125839] 'process raft request' (duration: 2.795607192s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:55.750850Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:52.953925Z","time spent":"2.796879381s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:55.749937Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.066207735s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T15:04:55.751330Z","caller":"traceutil/trace.go:172","msg":"trace[2131943295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"3.06764291s","start":"2026-04-13T15:04:52.683664Z","end":"2026-04-13T15:04:55.751307Z","steps":["trace[2131943295] 'agreement among raft nodes before linearized reading' (duration: 1.490433016s)","trace[2131943295] 'range keys from in-memory index tree' (duration: 1.574462619s)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:55.752602Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:52.683641Z","time spent":"3.068940269s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:56.250499Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215972,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:04:56.751375Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215972,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:04:56.770966Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000729373s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-13T15:04:56.771233Z","caller":"traceutil/trace.go:172","msg":"trace[380078025] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001012403s","start":"2026-04-13T15:04:54.770194Z","end":"2026-04-13T15:04:56.771206Z","steps":["trace[380078025] 'agreement among raft nodes before linearized reading' (duration: 2.000722632s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:56.771396Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:54.770179Z","time spent":"2.001190821s","remote":"127.0.0.1:50408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/13 15:04:56 WARNING: [core] [Server #5]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-13T15:04:57.252216Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963215972,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:04:57.542565Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.952073557s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T15:04:57.542715Z","caller":"traceutil/trace.go:172","msg":"trace[785954270] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:641; }","duration":"1.792432472s","start":"2026-04-13T15:04:55.750254Z","end":"2026-04-13T15:04:57.542687Z","steps":["trace[785954270] 'read index received' (duration: 1.792421472s)","trace[785954270] 'applied index is now lower than readState.Index' (duration: 6.91µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:57.664456Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.914629795s","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-13T15:04:57.664550Z","caller":"traceutil/trace.go:172","msg":"trace[1985290771] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:612; }","duration":"1.914728739s","start":"2026-04-13T15:04:55.749798Z","end":"2026-04-13T15:04:57.664526Z","steps":["trace[1985290771] 'agreement among raft nodes before linearized reading' (duration: 1.792989324s)","trace[1985290771] 'range keys from in-memory index tree' (duration: 121.613869ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:57.664555Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"121.653951ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:04:57.664749Z","caller":"traceutil/trace.go:172","msg":"trace[634085060] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.908886116s","start":"2026-04-13T15:04:55.755847Z","end":"2026-04-13T15:04:57.664733Z","steps":["trace[634085060] 'process raft request' (duration: 1.908799682s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:57.664832Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:55.755827Z","time spent":"1.908975328s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:04:57.664871Z","caller":"traceutil/trace.go:172","msg":"trace[2072784269] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"2.074477667s","start":"2026-04-13T15:04:55.590366Z","end":"2026-04-13T15:04:57.664843Z","steps":["trace[2072784269] 'process raft request' (duration: 1.952460512s)","trace[2072784269] 'compare' (duration: 121.049647ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:57.664892Z","caller":"traceutil/trace.go:172","msg":"trace[1526887974] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"890.044232ms","start":"2026-04-13T15:04:56.774830Z","end":"2026-04-13T15:04:57.664874Z","steps":["trace[1526887974] 'process raft request' (duration: 889.959529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:57.664994Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:55.590339Z","time spent":"2.074590411s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:57.665010Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:56.774791Z","time spent":"890.159257ms","remote":"127.0.0.1:50532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":769,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T15:04:57.665107Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"885.416633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:04:57.665129Z","caller":"traceutil/trace.go:172","msg":"trace[195470695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"885.438414ms","start":"2026-04-13T15:04:56.779685Z","end":"2026-04-13T15:04:57.665123Z","steps":["trace[195470695] 'agreement among raft nodes before linearized reading' (duration: 885.394192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:57.665144Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:56.779645Z","time spent":"885.495326ms","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T15:04:57.665068Z","caller":"traceutil/trace.go:172","msg":"trace[660149264] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"122.280515ms","start":"2026-04-13T15:04:57.542769Z","end":"2026-04-13T15:04:57.665049Z","steps":["trace[660149264] 'read index received' (duration: 108.598876ms)","trace[660149264] 'applied index is now lower than readState.Index' (duration: 13.677059ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:57.665266Z","caller":"traceutil/trace.go:172","msg":"trace[152445748] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.907789954s","start":"2026-04-13T15:04:55.757460Z","end":"2026-04-13T15:04:57.665250Z","steps":["trace[152445748] 'process raft request' (duration: 1.907237922s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:57.665350Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:55.757449Z","time spent":"1.907855117s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:04:57.665388Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.556294601s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.49\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-13T15:04:57.665431Z","caller":"traceutil/trace.go:172","msg":"trace[2104105164] range","detail":"{range_begin:/registry/masterleases/199.204.45.49; range_end:; response_count:1; response_revision:616; }","duration":"1.556338353s","start":"2026-04-13T15:04:56.109080Z","end":"2026-04-13T15:04:57.665419Z","steps":["trace[2104105164] 'agreement among raft nodes before linearized reading' (duration: 1.556166696s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:57.665458Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:56.109056Z","time spent":"1.556395035s","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.49\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:04:57.665441Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.902336906s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:04:57.665948Z","caller":"traceutil/trace.go:172","msg":"trace[1080295421] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:616; }","duration":"1.902849996s","start":"2026-04-13T15:04:55.763027Z","end":"2026-04-13T15:04:57.665876Z","steps":["trace[1080295421] 'agreement among raft nodes before linearized reading' (duration: 1.902236222s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:04:57.666052Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:55.763004Z","time spent":"1.902983752s","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" limit:1 "} {"level":"info","ts":"2026-04-13T15:04:58.537624Z","caller":"traceutil/trace.go:172","msg":"trace[1474057272] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"291.688217ms","start":"2026-04-13T15:04:58.245915Z","end":"2026-04-13T15:04:58.537603Z","steps":["trace[1474057272] 'process raft request' (duration: 291.556682ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:58.925131Z","caller":"traceutil/trace.go:172","msg":"trace[1333847789] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:653; }","duration":"155.480585ms","start":"2026-04-13T15:04:58.769620Z","end":"2026-04-13T15:04:58.925101Z","steps":["trace[1333847789] 'read index received' (duration: 155.468654ms)","trace[1333847789] 'applied index is now lower than readState.Index' (duration: 10.231µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:58.992036Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"222.454842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:04:58.992144Z","caller":"traceutil/trace.go:172","msg":"trace[625160238] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"222.567446ms","start":"2026-04-13T15:04:58.769566Z","end":"2026-04-13T15:04:58.992133Z","steps":["trace[625160238] 'agreement among raft nodes before linearized reading' (duration: 155.6196ms)","trace[625160238] 'range keys from in-memory index tree' (duration: 66.80837ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:04:58.992164Z","caller":"traceutil/trace.go:172","msg":"trace[789781222] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"437.006496ms","start":"2026-04-13T15:04:58.555139Z","end":"2026-04-13T15:04:58.992145Z","steps":["trace[789781222] 'process raft request' (duration: 370.011688ms)","trace[789781222] 'compare' (duration: 66.748448ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:04:58.992245Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:58.555119Z","time spent":"437.088368ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2738,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T15:04:58.992057Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"356.398044ms","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-13T15:04:58.992359Z","caller":"traceutil/trace.go:172","msg":"trace[1932801551] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:623; }","duration":"356.712886ms","start":"2026-04-13T15:04:58.635632Z","end":"2026-04-13T15:04:58.992345Z","steps":["trace[1932801551] 'range keys from in-memory index tree' (duration: 356.352722ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:59.187996Z","caller":"traceutil/trace.go:172","msg":"trace[2067381150] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"186.989311ms","start":"2026-04-13T15:04:59.000985Z","end":"2026-04-13T15:04:59.187975Z","steps":["trace[2067381150] 'process raft request' (duration: 186.927368ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:59.188083Z","caller":"traceutil/trace.go:172","msg":"trace[178746943] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"189.074814ms","start":"2026-04-13T15:04:58.998988Z","end":"2026-04-13T15:04:59.188063Z","steps":["trace[178746943] 'process raft request' (duration: 188.893507ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:59.187987Z","caller":"traceutil/trace.go:172","msg":"trace[1872161974] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"188.98864ms","start":"2026-04-13T15:04:58.998975Z","end":"2026-04-13T15:04:59.187964Z","steps":["trace[1872161974] 'process raft request' (duration: 187.618134ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:59.703361Z","caller":"traceutil/trace.go:172","msg":"trace[1421870329] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"130.204869ms","start":"2026-04-13T15:04:59.573028Z","end":"2026-04-13T15:04:59.703233Z","steps":["trace[1421870329] 'process raft request' (duration: 129.944899ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:04:59.941599Z","caller":"traceutil/trace.go:172","msg":"trace[987669155] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:660; }","duration":"170.073416ms","start":"2026-04-13T15:04:59.771506Z","end":"2026-04-13T15:04:59.941579Z","steps":["trace[987669155] 'read index received' (duration: 170.066646ms)","trace[987669155] 'applied index is now lower than readState.Index' (duration: 5.69µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:00.017807Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"246.286363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:00.017888Z","caller":"traceutil/trace.go:172","msg":"trace[154742886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"246.369076ms","start":"2026-04-13T15:04:59.771499Z","end":"2026-04-13T15:05:00.017868Z","steps":["trace[154742886] 'agreement among raft nodes before linearized reading' (duration: 170.147408ms)","trace[154742886] 'range keys from in-memory index tree' (duration: 76.116313ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:05:00.018022Z","caller":"traceutil/trace.go:172","msg":"trace[632712636] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"310.392152ms","start":"2026-04-13T15:04:59.707606Z","end":"2026-04-13T15:05:00.017998Z","steps":["trace[632712636] 'process raft request' (duration: 234.040439ms)","trace[632712636] 'compare' (duration: 76.054791ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:00.018194Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:59.707588Z","time spent":"310.531628ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:05:00.020908Z","caller":"traceutil/trace.go:172","msg":"trace[1130818726] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"312.581923ms","start":"2026-04-13T15:04:59.708314Z","end":"2026-04-13T15:05:00.020896Z","steps":["trace[1130818726] 'process raft request' (duration: 312.111773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:00.020981Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:04:59.708298Z","time spent":"312.646415ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:05:00.021300Z","caller":"traceutil/trace.go:172","msg":"trace[1815492787] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"259.334043ms","start":"2026-04-13T15:04:59.761933Z","end":"2026-04-13T15:05:00.021267Z","steps":["trace[1815492787] 'process raft request' (duration: 259.103383ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:00.021374Z","caller":"traceutil/trace.go:172","msg":"trace[377900476] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"258.377304ms","start":"2026-04-13T15:04:59.762981Z","end":"2026-04-13T15:05:00.021358Z","steps":["trace[377900476] 'process raft request' (duration: 258.135495ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:00.254810Z","caller":"traceutil/trace.go:172","msg":"trace[1616354513] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"219.526445ms","start":"2026-04-13T15:05:00.035266Z","end":"2026-04-13T15:05:00.254792Z","steps":["trace[1616354513] 'process raft request' (duration: 219.383869ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:00.397925Z","caller":"traceutil/trace.go:172","msg":"trace[296522684] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"151.351962ms","start":"2026-04-13T15:05:00.246524Z","end":"2026-04-13T15:05:00.397876Z","steps":["trace[296522684] 'process raft request' (duration: 98.467077ms)","trace[296522684] 'compare' (duration: 52.668316ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:05:01.437685Z","caller":"traceutil/trace.go:172","msg":"trace[1717067217] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"479.204083ms","start":"2026-04-13T15:05:00.958464Z","end":"2026-04-13T15:05:01.437668Z","steps":["trace[1717067217] 'process raft request' (duration: 479.056307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:01.437907Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:00.958440Z","time spent":"479.323968ms","remote":"127.0.0.1:50532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T15:05:02.041179Z","caller":"traceutil/trace.go:172","msg":"trace[771293909] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:667; }","duration":"270.427709ms","start":"2026-04-13T15:05:01.770733Z","end":"2026-04-13T15:05:02.041161Z","steps":["trace[771293909] 'read index received' (duration: 270.404348ms)","trace[771293909] 'applied index is now lower than readState.Index' (duration: 22.531µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:02.078209Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"307.459522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:02.078271Z","caller":"traceutil/trace.go:172","msg":"trace[618726353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"307.528055ms","start":"2026-04-13T15:05:01.770728Z","end":"2026-04-13T15:05:02.078256Z","steps":["trace[618726353] 'agreement among raft nodes before linearized reading' (duration: 270.538553ms)","trace[618726353] 'range keys from in-memory index tree' (duration: 36.884387ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:02.078299Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:01.770709Z","time spent":"307.583648ms","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T15:05:02.078275Z","caller":"traceutil/trace.go:172","msg":"trace[1008722084] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.107184259s","start":"2026-04-13T15:05:00.971062Z","end":"2026-04-13T15:05:02.078247Z","steps":["trace[1008722084] 'process raft request' (duration: 1.070233479s)","trace[1008722084] 'compare' (duration: 36.554563ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:02.079420Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"443.501122ms","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-13T15:05:02.079477Z","caller":"traceutil/trace.go:172","msg":"trace[558947980] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:637; }","duration":"443.589247ms","start":"2026-04-13T15:05:01.635876Z","end":"2026-04-13T15:05:02.079465Z","steps":["trace[558947980] 'range keys from in-memory index tree' (duration: 442.73258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:02.078648Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:00.971039Z","time spent":"1.107295353s","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18866,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:05:02.311358Z","caller":"traceutil/trace.go:172","msg":"trace[846795110] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:668; }","duration":"270.064563ms","start":"2026-04-13T15:05:02.041240Z","end":"2026-04-13T15:05:02.311304Z","steps":["trace[846795110] 'read index received' (duration: 270.056473ms)","trace[846795110] 'applied index is now lower than readState.Index' (duration: 6.72µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:02.319554Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"296.945947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T15:05:02.319619Z","caller":"traceutil/trace.go:172","msg":"trace[1513383563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"297.027551ms","start":"2026-04-13T15:05:02.022579Z","end":"2026-04-13T15:05:02.319607Z","steps":["trace[1513383563] 'agreement among raft nodes before linearized reading' (duration: 288.866486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:02.319554Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"293.418828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-13T15:05:02.319728Z","caller":"traceutil/trace.go:172","msg":"trace[449310586] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"293.601176ms","start":"2026-04-13T15:05:02.026106Z","end":"2026-04-13T15:05:02.319708Z","steps":["trace[449310586] 'agreement among raft nodes before linearized reading' (duration: 285.287755ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:02.367393Z","caller":"traceutil/trace.go:172","msg":"trace[2059512069] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"340.087239ms","start":"2026-04-13T15:05:02.027277Z","end":"2026-04-13T15:05:02.367364Z","steps":["trace[2059512069] 'process raft request' (duration: 339.736784ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:02.367428Z","caller":"traceutil/trace.go:172","msg":"trace[1953930536] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"339.383948ms","start":"2026-04-13T15:05:02.028014Z","end":"2026-04-13T15:05:02.367398Z","steps":["trace[1953930536] 'process raft request' (duration: 339.217531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:02.367479Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"287.556381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:02.367522Z","caller":"traceutil/trace.go:172","msg":"trace[1167002911] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"287.591913ms","start":"2026-04-13T15:05:02.079915Z","end":"2026-04-13T15:05:02.367507Z","steps":["trace[1167002911] 'agreement among raft nodes before linearized reading' (duration: 287.53475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:02.367530Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:02.027229Z","time spent":"340.239585ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:05:02.367403Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"287.867204ms","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-13T15:05:02.367559Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:02.027980Z","time spent":"339.507154ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:05:02.367609Z","caller":"traceutil/trace.go:172","msg":"trace[1912531151] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:640; }","duration":"288.084503ms","start":"2026-04-13T15:05:02.079509Z","end":"2026-04-13T15:05:02.367593Z","steps":["trace[1912531151] 'agreement among raft nodes before linearized reading' (duration: 287.847043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:02.683870Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"211.207628ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:05:02.684031Z","caller":"traceutil/trace.go:172","msg":"trace[1298182766] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"358.696314ms","start":"2026-04-13T15:05:02.325289Z","end":"2026-04-13T15:05:02.683985Z","steps":["trace[1298182766] 'process raft request' (duration: 147.192753ms)","trace[1298182766] 'compare' (duration: 211.068993ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:02.684144Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:02.325262Z","time spent":"358.82919ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":424,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:05:03.368084Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"117.287495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:03.368214Z","caller":"traceutil/trace.go:172","msg":"trace[1918272634] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"117.450223ms","start":"2026-04-13T15:05:03.250738Z","end":"2026-04-13T15:05:03.368188Z","steps":["trace[1918272634] 'range keys from in-memory index tree' (duration: 117.200381ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:03.548676Z","caller":"traceutil/trace.go:172","msg":"trace[1568995913] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"173.379945ms","start":"2026-04-13T15:05:03.375280Z","end":"2026-04-13T15:05:03.548660Z","steps":["trace[1568995913] 'process raft request' (duration: 173.27268ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:04.758675Z","caller":"traceutil/trace.go:172","msg":"trace[892158439] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:676; }","duration":"341.862181ms","start":"2026-04-13T15:05:04.416787Z","end":"2026-04-13T15:05:04.758649Z","steps":["trace[892158439] 'read index received' (duration: 341.851141ms)","trace[892158439] 'applied index is now lower than readState.Index' (duration: 10.03µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:04.760321Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"343.507043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T15:05:04.760377Z","caller":"traceutil/trace.go:172","msg":"trace[729832680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:645; }","duration":"343.583616ms","start":"2026-04-13T15:05:04.416781Z","end":"2026-04-13T15:05:04.760364Z","steps":["trace[729832680] 'agreement among raft nodes before linearized reading' (duration: 341.989347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:04.760415Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:04.416761Z","time spent":"343.644949ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:05:04.760394Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"791.903699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jd8gd\" limit:1 ","response":"range_response_count:1 size:18881"} {"level":"info","ts":"2026-04-13T15:05:04.760734Z","caller":"traceutil/trace.go:172","msg":"trace[1932299940] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jd8gd; range_end:; response_count:1; response_revision:645; }","duration":"792.266924ms","start":"2026-04-13T15:05:03.968455Z","end":"2026-04-13T15:05:04.760722Z","steps":["trace[1932299940] 'range keys from in-memory index tree' (duration: 791.738091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:04.760777Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:03.968436Z","time spent":"792.325266ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18905,"request content":"key:\"/registry/pods/kube-system/cilium-jd8gd\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:05:04.761104Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"124.800813ms","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-13T15:05:04.761445Z","caller":"traceutil/trace.go:172","msg":"trace[1929543376] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:645; }","duration":"125.274794ms","start":"2026-04-13T15:05:04.636148Z","end":"2026-04-13T15:05:04.761423Z","steps":["trace[1929543376] 'range keys from in-memory index tree' (duration: 124.74636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:04.761487Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"330.070121ms","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-13T15:05:04.761593Z","caller":"traceutil/trace.go:172","msg":"trace[845827183] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"388.601354ms","start":"2026-04-13T15:05:04.372970Z","end":"2026-04-13T15:05:04.761572Z","steps":["trace[845827183] 'process raft request' (duration: 388.083812ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:04.761160Z","caller":"traceutil/trace.go:172","msg":"trace[1605069882] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"388.169726ms","start":"2026-04-13T15:05:04.372969Z","end":"2026-04-13T15:05:04.761139Z","steps":["trace[1605069882] 'process raft request' (duration: 385.71925ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:04.761569Z","caller":"traceutil/trace.go:172","msg":"trace[1836504959] range","detail":"{range_begin:/registry/priorityclasses; range_end:; response_count:0; response_revision:647; }","duration":"330.165295ms","start":"2026-04-13T15:05:04.431392Z","end":"2026-04-13T15:05:04.761557Z","steps":["trace[1836504959] 'agreement among raft nodes before linearized reading' (duration: 330.04268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:04.761749Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:04.372939Z","time spent":"388.73226ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:05:04.761914Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:04.431377Z","time spent":"330.520771ms","remote":"127.0.0.1:51148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":29,"request content":"key:\"/registry/priorityclasses\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:05:04.761890Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:04.372939Z","time spent":"388.771052ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:05:04.761798Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"299.618142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:04.762094Z","caller":"traceutil/trace.go:172","msg":"trace[1153205494] range","detail":"{range_begin:/registry/horizontalpodautoscalers; range_end:; response_count:0; response_revision:647; }","duration":"299.938506ms","start":"2026-04-13T15:05:04.462140Z","end":"2026-04-13T15:05:04.762078Z","steps":["trace[1153205494] 'agreement among raft nodes before linearized reading' (duration: 299.592711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:04.762152Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"320.568649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:04.762189Z","caller":"traceutil/trace.go:172","msg":"trace[990194762] range","detail":"{range_begin:/registry/validatingwebhookconfigurations; range_end:; response_count:0; response_revision:647; }","duration":"320.603781ms","start":"2026-04-13T15:05:04.441574Z","end":"2026-04-13T15:05:04.762178Z","steps":["trace[990194762] 'agreement among raft nodes before linearized reading' (duration: 320.545767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:04.762217Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:04.441546Z","time spent":"320.664044ms","remote":"127.0.0.1:51376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/validatingwebhookconfigurations\" limit:1 "} {"level":"info","ts":"2026-04-13T15:05:06.212602Z","caller":"traceutil/trace.go:172","msg":"trace[966841319] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:689; }","duration":"156.084311ms","start":"2026-04-13T15:05:06.056488Z","end":"2026-04-13T15:05:06.212572Z","steps":["trace[966841319] 'read index received' (duration: 156.07412ms)","trace[966841319] 'applied index is now lower than readState.Index' (duration: 8.59µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:06.212809Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"156.29187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:06.212877Z","caller":"traceutil/trace.go:172","msg":"trace[792053424] range","detail":"{range_begin:/registry/ingressclasses; range_end:; response_count:0; response_revision:658; }","duration":"156.377703ms","start":"2026-04-13T15:05:06.056484Z","end":"2026-04-13T15:05:06.212862Z","steps":["trace[792053424] 'agreement among raft nodes before linearized reading' (duration: 156.243637ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:06.212818Z","caller":"traceutil/trace.go:172","msg":"trace[955341936] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"215.292153ms","start":"2026-04-13T15:05:05.997512Z","end":"2026-04-13T15:05:06.212804Z","steps":["trace[955341936] 'process raft request' (duration: 215.178258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:06.319112Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"209.504689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.49\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-13T15:05:06.319171Z","caller":"traceutil/trace.go:172","msg":"trace[1369386763] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"309.93333ms","start":"2026-04-13T15:05:06.009216Z","end":"2026-04-13T15:05:06.319149Z","steps":["trace[1369386763] 'process raft request' (duration: 245.368248ms)","trace[1369386763] 'compare' (duration: 64.399375ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:05:06.319171Z","caller":"traceutil/trace.go:172","msg":"trace[460860073] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"102.530145ms","start":"2026-04-13T15:05:06.216622Z","end":"2026-04-13T15:05:06.319153Z","steps":["trace[460860073] 'process raft request' (duration: 102.483433ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:06.319211Z","caller":"traceutil/trace.go:172","msg":"trace[1092235736] range","detail":"{range_begin:/registry/masterleases/199.204.45.49; range_end:; response_count:1; response_revision:659; }","duration":"209.594753ms","start":"2026-04-13T15:05:06.109580Z","end":"2026-04-13T15:05:06.319175Z","steps":["trace[1092235736] 'agreement among raft nodes before linearized reading' (duration: 144.892274ms)","trace[1092235736] 'range keys from in-memory index tree' (duration: 64.490299ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:06.319285Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:06.009196Z","time spent":"310.019154ms","remote":"127.0.0.1:50712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19387,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:05:12.733719Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52714","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.189636Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52746","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.205946Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52776","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.232783Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52812","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.393721Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52840","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.418082Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52844","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.438811Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52864","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.464856Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52884","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.517645Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52904","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.566673Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52920","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.590528Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52940","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.630657Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52950","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.677220Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:52984","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.694343Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53006","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.728537Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53016","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.751856Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53028","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.765115Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53042","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.879546Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53058","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.924214Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53074","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.945452Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53096","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.970851Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53102","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.982341Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53122","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:13.996885Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53142","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:14.008862Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53160","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:14.021721Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53194","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:14.039584Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53204","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:14.108578Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53220","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:14.171381Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53254","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:14.182635Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53266","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:14.198195Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53294","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:14.211142Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53306","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-13T15:05:14.684931Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:53310","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-13T15:05:20.899816Z","caller":"traceutil/trace.go:172","msg":"trace[1192269969] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"209.621926ms","start":"2026-04-13T15:05:20.690175Z","end":"2026-04-13T15:05:20.899797Z","steps":["trace[1192269969] 'process raft request' (duration: 209.450247ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:20.899828Z","caller":"traceutil/trace.go:172","msg":"trace[1211158236] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:838; }","duration":"112.174896ms","start":"2026-04-13T15:05:20.787496Z","end":"2026-04-13T15:05:20.899671Z","steps":["trace[1211158236] 'read index received' (duration: 112.162746ms)","trace[1211158236] 'applied index is now lower than readState.Index' (duration: 9.97µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:20.900023Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"112.372587ms","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-13T15:05:20.900213Z","caller":"traceutil/trace.go:172","msg":"trace[1983234272] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:803; }","duration":"112.713794ms","start":"2026-04-13T15:05:20.787479Z","end":"2026-04-13T15:05:20.900193Z","steps":["trace[1983234272] 'agreement among raft nodes before linearized reading' (duration: 112.300103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:24.699861Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256278126963216516,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T15:05:25.167120Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.028182466s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T15:05:25.167544Z","caller":"traceutil/trace.go:172","msg":"trace[2138047416] linearizableReadLoop","detail":"{readStateIndex:858; appliedIndex:858; }","duration":"968.773665ms","start":"2026-04-13T15:05:24.198746Z","end":"2026-04-13T15:05:25.167520Z","steps":["trace[2138047416] 'read index received' (duration: 968.761434ms)","trace[2138047416] 'applied index is now lower than readState.Index' (duration: 10.24µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:25.167702Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"968.945154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:25.167734Z","caller":"traceutil/trace.go:172","msg":"trace[1492179099] range","detail":"{range_begin:/registry/minions; range_end:; response_count:0; response_revision:821; }","duration":"968.995906ms","start":"2026-04-13T15:05:24.198730Z","end":"2026-04-13T15:05:25.167726Z","steps":["trace[1492179099] 'agreement among raft nodes before linearized reading' (duration: 968.906242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:25.167761Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:24.198707Z","time spent":"969.048039ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":29,"request content":"key:\"/registry/minions\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:05:25.167884Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.916476492s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:25.167962Z","caller":"traceutil/trace.go:172","msg":"trace[2066501736] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:821; }","duration":"1.916559047s","start":"2026-04-13T15:05:23.251383Z","end":"2026-04-13T15:05:25.167942Z","steps":["trace[2066501736] 'range keys from in-memory index tree' (duration: 1.916381187s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:25.168008Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:23.251359Z","time spent":"1.916640231s","remote":"127.0.0.1:50420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T15:05:25.168362Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.397713512s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:25.168446Z","caller":"traceutil/trace.go:172","msg":"trace[1005659559] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:821; }","duration":"1.397801006s","start":"2026-04-13T15:05:23.770630Z","end":"2026-04-13T15:05:25.168431Z","steps":["trace[1005659559] 'range keys from in-memory index tree' (duration: 1.397630748s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:25.168476Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:23.770610Z","time spent":"1.397860259s","remote":"127.0.0.1:50408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T15:05:25.168502Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.532519971s","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-13T15:05:25.168547Z","caller":"traceutil/trace.go:172","msg":"trace[2023430444] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:821; }","duration":"1.532567893s","start":"2026-04-13T15:05:23.635969Z","end":"2026-04-13T15:05:25.168537Z","steps":["trace[2023430444] 'range keys from in-memory index tree' (duration: 1.532474248s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:25.168486Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.537070687s","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-13T15:05:25.168599Z","caller":"traceutil/trace.go:172","msg":"trace[1605377422] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:821; }","duration":"1.537197844s","start":"2026-04-13T15:05:23.631391Z","end":"2026-04-13T15:05:25.168589Z","steps":["trace[1605377422] 'range keys from in-memory index tree' (duration: 1.536915079s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:25.168626Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:23.631370Z","time spent":"1.537246536s","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"info","ts":"2026-04-13T15:05:25.168630Z","caller":"traceutil/trace.go:172","msg":"trace[1427777553] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"1.029798432s","start":"2026-04-13T15:05:24.138821Z","end":"2026-04-13T15:05:25.168619Z","steps":["trace[1427777553] 'process raft request' (duration: 1.028725665s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:25.168710Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:24.138802Z","time spent":"1.029854855s","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2879,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:05:25.170535Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"227.479769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-13T15:05:25.170600Z","caller":"traceutil/trace.go:172","msg":"trace[1805226063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:822; }","duration":"227.544202ms","start":"2026-04-13T15:05:24.943040Z","end":"2026-04-13T15:05:25.170584Z","steps":["trace[1805226063] 'agreement among raft nodes before linearized reading' (duration: 227.196164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:25.171196Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"313.00044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T15:05:25.171693Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"928.215493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:25.171948Z","caller":"traceutil/trace.go:172","msg":"trace[1385561116] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations; range_end:; response_count:0; response_revision:822; }","duration":"313.742708ms","start":"2026-04-13T15:05:24.858179Z","end":"2026-04-13T15:05:25.171921Z","steps":["trace[1385561116] 'agreement among raft nodes before linearized reading' (duration: 312.960957ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:25.171946Z","caller":"traceutil/trace.go:172","msg":"trace[1467124922] range","detail":"{range_begin:/registry/persistentvolumes; range_end:; response_count:0; response_revision:822; }","duration":"928.651356ms","start":"2026-04-13T15:05:24.243279Z","end":"2026-04-13T15:05:25.171930Z","steps":["trace[1467124922] 'agreement among raft nodes before linearized reading' (duration: 927.835253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:25.172281Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:24.243223Z","time spent":"929.037296ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:05:25.171847Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"229.307746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T15:05:25.172994Z","caller":"traceutil/trace.go:172","msg":"trace[1672818781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:822; }","duration":"230.456736ms","start":"2026-04-13T15:05:24.942525Z","end":"2026-04-13T15:05:25.172981Z","steps":["trace[1672818781] 'agreement among raft nodes before linearized reading' (duration: 228.24985ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:25.173082Z","caller":"traceutil/trace.go:172","msg":"trace[119483496] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"243.446507ms","start":"2026-04-13T15:05:24.929626Z","end":"2026-04-13T15:05:25.173072Z","steps":["trace[119483496] 'process raft request' (duration: 241.573629ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:25.173449Z","caller":"traceutil/trace.go:172","msg":"trace[568454139] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"240.806677ms","start":"2026-04-13T15:05:24.932632Z","end":"2026-04-13T15:05:25.173439Z","steps":["trace[568454139] 'process raft request' (duration: 239.939381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:25.172348Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:24.858162Z","time spent":"314.083235ms","remote":"127.0.0.1:51410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations\" limit:1 "} {"level":"info","ts":"2026-04-13T15:05:29.093532Z","caller":"traceutil/trace.go:172","msg":"trace[1271061180] linearizableReadLoop","detail":"{readStateIndex:905; appliedIndex:905; }","duration":"209.646897ms","start":"2026-04-13T15:05:28.883855Z","end":"2026-04-13T15:05:29.093502Z","steps":["trace[1271061180] 'read index received' (duration: 209.633787ms)","trace[1271061180] 'applied index is now lower than readState.Index' (duration: 11.05µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:29.093698Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"209.816866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:29.093746Z","caller":"traceutil/trace.go:172","msg":"trace[955745137] range","detail":"{range_begin:/registry/rolebindings; range_end:; response_count:0; response_revision:867; }","duration":"209.874589ms","start":"2026-04-13T15:05:28.883850Z","end":"2026-04-13T15:05:29.093725Z","steps":["trace[955745137] 'agreement among raft nodes before linearized reading' (duration: 209.769624ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:29.094444Z","caller":"traceutil/trace.go:172","msg":"trace[818021925] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"437.364156ms","start":"2026-04-13T15:05:28.657063Z","end":"2026-04-13T15:05:29.094427Z","steps":["trace[818021925] 'process raft request' (duration: 436.584174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:29.094566Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:28.657031Z","time spent":"437.475932ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036306,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:05:29.623050Z","caller":"traceutil/trace.go:172","msg":"trace[1977390153] linearizableReadLoop","detail":"{readStateIndex:906; appliedIndex:906; }","duration":"426.929506ms","start":"2026-04-13T15:05:29.196083Z","end":"2026-04-13T15:05:29.623013Z","steps":["trace[1977390153] 'read index received' (duration: 426.919735ms)","trace[1977390153] 'applied index is now lower than readState.Index' (duration: 8.201µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:29.623326Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"427.218861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-13T15:05:29.623380Z","caller":"traceutil/trace.go:172","msg":"trace[1604861204] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:868; }","duration":"427.291715ms","start":"2026-04-13T15:05:29.196078Z","end":"2026-04-13T15:05:29.623370Z","steps":["trace[1604861204] 'agreement among raft nodes before linearized reading' (duration: 427.089934ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:29.623359Z","caller":"traceutil/trace.go:172","msg":"trace[1077188144] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"440.245497ms","start":"2026-04-13T15:05:29.183088Z","end":"2026-04-13T15:05:29.623333Z","steps":["trace[1077188144] 'process raft request' (duration: 440.004324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:29.623414Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:29.196054Z","time spent":"427.352058ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:05:29.623531Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:29.183070Z","time spent":"440.360613ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:05:29.629848Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"430.606163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T15:05:29.629905Z","caller":"traceutil/trace.go:172","msg":"trace[1219907499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:869; }","duration":"430.672587ms","start":"2026-04-13T15:05:29.199221Z","end":"2026-04-13T15:05:29.629894Z","steps":["trace[1219907499] 'agreement among raft nodes before linearized reading' (duration: 430.518078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:29.629931Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:29.199210Z","time spent":"430.715989ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:05:29.630134Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"395.841828ms","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-13T15:05:29.630160Z","caller":"traceutil/trace.go:172","msg":"trace[2118662306] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:869; }","duration":"395.86782ms","start":"2026-04-13T15:05:29.234286Z","end":"2026-04-13T15:05:29.630154Z","steps":["trace[2118662306] 'agreement among raft nodes before linearized reading' (duration: 395.827667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:29.630175Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:29.234267Z","time spent":"395.904032ms","remote":"127.0.0.1:50566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":29,"request content":"key:\"/registry/secrets\" limit:1 "} {"level":"warn","ts":"2026-04-13T15:05:29.630324Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"430.860247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-13T15:05:29.630369Z","caller":"traceutil/trace.go:172","msg":"trace[570952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:869; }","duration":"430.907169ms","start":"2026-04-13T15:05:29.199448Z","end":"2026-04-13T15:05:29.630355Z","steps":["trace[570952] 'agreement among raft nodes before linearized reading' (duration: 430.762822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:29.630389Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:29.199426Z","time spent":"430.959052ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-04-13T15:05:29.630614Z","caller":"traceutil/trace.go:172","msg":"trace[903822104] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"444.953443ms","start":"2026-04-13T15:05:29.185649Z","end":"2026-04-13T15:05:29.630602Z","steps":["trace[903822104] 'process raft request' (duration: 444.866857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:29.630709Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:29.185642Z","time spent":"445.014846ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:05:29.942637Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"172.216081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:05:29.942706Z","caller":"traceutil/trace.go:172","msg":"trace[1724278828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:871; }","duration":"172.291495ms","start":"2026-04-13T15:05:29.770401Z","end":"2026-04-13T15:05:29.942693Z","steps":["trace[1724278828] 'range keys from in-memory index tree' (duration: 166.575405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:29.942775Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"166.615348ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:05:29.943132Z","caller":"traceutil/trace.go:172","msg":"trace[18422122] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:909; }","duration":"111.799743ms","start":"2026-04-13T15:05:29.831324Z","end":"2026-04-13T15:05:29.943123Z","steps":["trace[18422122] 'read index received' (duration: 30.751µs)","trace[18422122] 'applied index is now lower than readState.Index' (duration: 111.767952ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:29.943427Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"112.09883ms","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-13T15:05:29.943456Z","caller":"traceutil/trace.go:172","msg":"trace[1252160888] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:874; }","duration":"112.130302ms","start":"2026-04-13T15:05:29.831319Z","end":"2026-04-13T15:05:29.943449Z","steps":["trace[1252160888] 'agreement among raft nodes before linearized reading' (duration: 112.079439ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:29.943576Z","caller":"traceutil/trace.go:172","msg":"trace[888659241] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"307.253363ms","start":"2026-04-13T15:05:29.636317Z","end":"2026-04-13T15:05:29.943570Z","steps":["trace[888659241] 'process raft request' (duration: 306.644321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:29.943624Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:29.636273Z","time spent":"307.325058ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":424,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:05:29.943423Z","caller":"traceutil/trace.go:172","msg":"trace[609187975] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"309.906628ms","start":"2026-04-13T15:05:29.633480Z","end":"2026-04-13T15:05:29.943386Z","steps":["trace[609187975] 'process raft request' (duration: 142.556321ms)","trace[609187975] 'compare' (duration: 166.337812ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:29.944094Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:29.633466Z","time spent":"310.565563ms","remote":"127.0.0.1:53300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1737,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T15:05:29.943585Z","caller":"traceutil/trace.go:172","msg":"trace[1560097340] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"307.468187ms","start":"2026-04-13T15:05:29.636087Z","end":"2026-04-13T15:05:29.943555Z","steps":["trace[1560097340] 'process raft request' (duration: 306.730877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:29.945248Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-13T15:05:29.636076Z","time spent":"308.233567ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:05:30.991883Z","caller":"traceutil/trace.go:172","msg":"trace[1012058294] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"127.995796ms","start":"2026-04-13T15:05:30.863867Z","end":"2026-04-13T15:05:30.991863Z","steps":["trace[1012058294] 'process raft request' (duration: 127.712341ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:05:52.213776Z","caller":"traceutil/trace.go:172","msg":"trace[170298622] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1006; }","duration":"118.505895ms","start":"2026-04-13T15:05:52.095193Z","end":"2026-04-13T15:05:52.213699Z","steps":["trace[170298622] 'read index received' (duration: 118.498294ms)","trace[170298622] 'applied index is now lower than readState.Index' (duration: 6.211µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:52.230117Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"134.910678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" limit:1 ","response":"range_response_count:1 size:1148"} {"level":"info","ts":"2026-04-13T15:05:52.231365Z","caller":"traceutil/trace.go:172","msg":"trace[1011615399] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:963; }","duration":"135.995514ms","start":"2026-04-13T15:05:52.095179Z","end":"2026-04-13T15:05:52.231175Z","steps":["trace[1011615399] 'agreement among raft nodes before linearized reading' (duration: 118.630502ms)","trace[1011615399] 'range keys from in-memory index tree' (duration: 16.132615ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:05:52.230763Z","caller":"traceutil/trace.go:172","msg":"trace[1963459063] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"176.791987ms","start":"2026-04-13T15:05:52.053944Z","end":"2026-04-13T15:05:52.230736Z","steps":["trace[1963459063] 'process raft request' (duration: 159.791728ms)","trace[1963459063] 'compare' (duration: 16.52374ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:05:58.085064Z","caller":"traceutil/trace.go:172","msg":"trace[1739297720] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1022; }","duration":"132.624863ms","start":"2026-04-13T15:05:57.952405Z","end":"2026-04-13T15:05:58.085029Z","steps":["trace[1739297720] 'read index received' (duration: 132.613143ms)","trace[1739297720] 'applied index is now lower than readState.Index' (duration: 9.87µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:05:58.146505Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"194.081868ms","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-13T15:05:58.146577Z","caller":"traceutil/trace.go:172","msg":"trace[978601345] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:978; }","duration":"194.158843ms","start":"2026-04-13T15:05:57.952399Z","end":"2026-04-13T15:05:58.146558Z","steps":["trace[978601345] 'agreement among raft nodes before linearized reading' (duration: 132.776544ms)","trace[978601345] 'range keys from in-memory index tree' (duration: 61.204758ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:05:58.147132Z","caller":"traceutil/trace.go:172","msg":"trace[76396915] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"254.701126ms","start":"2026-04-13T15:05:57.892409Z","end":"2026-04-13T15:05:58.147110Z","steps":["trace[76396915] 'process raft request' (duration: 192.844537ms)","trace[76396915] 'compare' (duration: 61.512107ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:05:58.147613Z","caller":"traceutil/trace.go:172","msg":"trace[337438024] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"252.864292ms","start":"2026-04-13T15:05:57.894741Z","end":"2026-04-13T15:05:58.147606Z","steps":["trace[337438024] 'process raft request' (duration: 252.283776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:05:58.148209Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"146.184513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" limit:1 ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-04-13T15:05:58.148292Z","caller":"traceutil/trace.go:172","msg":"trace[503110083] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:980; }","duration":"146.278079ms","start":"2026-04-13T15:05:58.001996Z","end":"2026-04-13T15:05:58.148274Z","steps":["trace[503110083] 'agreement among raft nodes before linearized reading' (duration: 145.345711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:06:06.387764Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"122.154238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-13T15:06:06.388060Z","caller":"traceutil/trace.go:172","msg":"trace[2082945426] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"137.602451ms","start":"2026-04-13T15:06:06.250278Z","end":"2026-04-13T15:06:06.387881Z","steps":["trace[2082945426] 'process raft request' (duration: 71.774522ms)","trace[2082945426] 'compare' (duration: 65.604394ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:06:06.388340Z","caller":"traceutil/trace.go:172","msg":"trace[1763527916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1010; }","duration":"122.667321ms","start":"2026-04-13T15:06:06.265574Z","end":"2026-04-13T15:06:06.388241Z","steps":["trace[1763527916] 'agreement among raft nodes before linearized reading' (duration: 56.426775ms)","trace[1763527916] 'range keys from in-memory index tree' (duration: 65.598305ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:06:06.614053Z","caller":"traceutil/trace.go:172","msg":"trace[91941542] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"221.423556ms","start":"2026-04-13T15:06:06.392363Z","end":"2026-04-13T15:06:06.613786Z","steps":["trace[91941542] 'process raft request' (duration: 185.84229ms)","trace[91941542] 'compare' (duration: 35.183041ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:06:06.629454Z","caller":"traceutil/trace.go:172","msg":"trace[1035094243] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"236.411729ms","start":"2026-04-13T15:06:06.393019Z","end":"2026-04-13T15:06:06.629430Z","steps":["trace[1035094243] 'process raft request' (duration: 236.291931ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:06:38.751811Z","caller":"traceutil/trace.go:172","msg":"trace[1781599521] linearizableReadLoop","detail":"{readStateIndex:1168; appliedIndex:1168; }","duration":"115.837514ms","start":"2026-04-13T15:06:38.635946Z","end":"2026-04-13T15:06:38.751784Z","steps":["trace[1781599521] 'read index received' (duration: 115.791881ms)","trace[1781599521] 'applied index is now lower than readState.Index' (duration: 8.22µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:06:38.754114Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"118.187816ms","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-13T15:06:38.754178Z","caller":"traceutil/trace.go:172","msg":"trace[365483149] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1116; }","duration":"118.267441ms","start":"2026-04-13T15:06:38.635899Z","end":"2026-04-13T15:06:38.754166Z","steps":["trace[365483149] 'agreement among raft nodes before linearized reading' (duration: 115.956792ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:06:38.754232Z","caller":"traceutil/trace.go:172","msg":"trace[566597283] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"199.752715ms","start":"2026-04-13T15:06:38.554458Z","end":"2026-04-13T15:06:38.754211Z","steps":["trace[566597283] 'process raft request' (duration: 197.476968ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:07:18.760207Z","caller":"traceutil/trace.go:172","msg":"trace[2068070733] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1306; }","duration":"100.948163ms","start":"2026-04-13T15:07:18.659226Z","end":"2026-04-13T15:07:18.760174Z","steps":["trace[2068070733] 'read index received' (duration: 100.935662ms)","trace[2068070733] 'applied index is now lower than readState.Index' (duration: 10.991µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:07:18.760483Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.281806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-root-ca.crt\" limit:1 ","response":"range_response_count:1 size:1746"} {"level":"info","ts":"2026-04-13T15:07:18.760519Z","caller":"traceutil/trace.go:172","msg":"trace[1097069857] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"101.343841ms","start":"2026-04-13T15:07:18.659151Z","end":"2026-04-13T15:07:18.760495Z","steps":["trace[1097069857] 'process raft request' (duration: 101.19082ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:07:18.760543Z","caller":"traceutil/trace.go:172","msg":"trace[635946760] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1246; }","duration":"101.352391ms","start":"2026-04-13T15:07:18.659174Z","end":"2026-04-13T15:07:18.760526Z","steps":["trace[635946760] 'agreement among raft nodes before linearized reading' (duration: 101.157887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:07:18.763155Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"100.531452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" limit:1 ","response":"range_response_count:1 size:1148"} {"level":"info","ts":"2026-04-13T15:07:18.763234Z","caller":"traceutil/trace.go:172","msg":"trace[600550259] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:1247; }","duration":"100.620388ms","start":"2026-04-13T15:07:18.662597Z","end":"2026-04-13T15:07:18.763217Z","steps":["trace[600550259] 'agreement among raft nodes before linearized reading' (duration: 100.436375ms)"],"step_count":1}