{"level":"warn","ts":"2026-03-30T16:45:54.409160Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-03-30T16:45:54.410270Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-03-30T16:45:54.410309Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.217:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.19.213.217:2380","--initial-cluster=controller=https://199.19.213.217:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.217:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.217: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-03-30T16:45:54.410485Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-03-30T16:45:54.410517Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-30T16:45:54.410533Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.217:2380"]} {"level":"info","ts":"2026-03-30T16:45:54.410586Z","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-03-30T16:45:54.411411Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.217:2379"]} {"level":"info","ts":"2026-03-30T16:45:54.411528Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.217:2380"],"listen-peer-urls":["https://199.19.213.217:2380"],"advertise-client-urls":["https://199.19.213.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.19.213.217: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-03-30T16:45:54.412799Z","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: 0xc0000785f8}"} {"level":"info","ts":"2026-03-30T16:45:54.419525Z","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-03-30T16:45:54.419571Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.84908ms"} {"level":"info","ts":"2026-03-30T16:45:54.419672Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-03-30T16:45:54.419726Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-03-30T16:45:54.419785Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-03-30T16:45:54.424978Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-03-30T16:45:54.425092Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"22141a955455b8ec","cluster-id":"30738c1f7233ae60"} {"level":"info","ts":"2026-03-30T16:45:54.425142Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-03-30T16:45:54.425244Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"22141a955455b8ec switched to configuration voters=()"} {"level":"info","ts":"2026-03-30T16:45:54.425329Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"22141a955455b8ec became follower at term 0"} {"level":"info","ts":"2026-03-30T16:45:54.425341Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft 22141a955455b8ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-30T16:45:54.425373Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"22141a955455b8ec became follower at term 1"} {"level":"info","ts":"2026-03-30T16:45:54.425421Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"22141a955455b8ec switched to configuration voters=(2455616925491116268)"} {"level":"warn","ts":"2026-03-30T16:45:54.429504Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-30T16:45:54.431663Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-30T16:45:54.434205Z","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-03-30T16:45:54.436843Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"22141a955455b8ec","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-30T16:45:54.437436Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"22141a955455b8ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-30T16:45:54.437500Z","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-03-30T16:45:54.437543Z","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-03-30T16:45:54.437596Z","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-03-30T16:45:54.437607Z","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-03-30T16:45:54.437962Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.19.213.217:2380"} {"level":"info","ts":"2026-03-30T16:45:54.437996Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.19.213.217:2380"} {"level":"info","ts":"2026-03-30T16:45:54.438189Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"22141a955455b8ec switched to configuration voters=(2455616925491116268)"} {"level":"info","ts":"2026-03-30T16:45:54.438302Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"30738c1f7233ae60","local-member-id":"22141a955455b8ec","added-peer-id":"22141a955455b8ec","added-peer-peer-urls":["https://199.19.213.217:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-03-30T16:45:54.439053Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"22141a955455b8ec","initial-advertise-peer-urls":["https://199.19.213.217:2380"],"listen-peer-urls":["https://199.19.213.217:2380"],"advertise-client-urls":["https://199.19.213.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-30T16:45:54.439123Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-30T16:45:54.725934Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"22141a955455b8ec is starting a new election at term 1"} {"level":"info","ts":"2026-03-30T16:45:54.726013Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"22141a955455b8ec became pre-candidate at term 1"} {"level":"info","ts":"2026-03-30T16:45:54.726091Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"22141a955455b8ec received MsgPreVoteResp from 22141a955455b8ec at term 1"} {"level":"info","ts":"2026-03-30T16:45:54.726119Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"22141a955455b8ec has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-03-30T16:45:54.726172Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"22141a955455b8ec became candidate at term 2"} {"level":"info","ts":"2026-03-30T16:45:54.726897Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"22141a955455b8ec received MsgVoteResp from 22141a955455b8ec at term 2"} {"level":"info","ts":"2026-03-30T16:45:54.726941Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"22141a955455b8ec has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-03-30T16:45:54.727040Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"22141a955455b8ec became leader at term 2"} {"level":"info","ts":"2026-03-30T16:45:54.727056Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: 22141a955455b8ec elected leader 22141a955455b8ec at term 2"} {"level":"info","ts":"2026-03-30T16:45:54.728041Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"22141a955455b8ec","local-member-attributes":"{Name:controller ClientURLs:[https://199.19.213.217:2379]}","cluster-id":"30738c1f7233ae60","publish-timeout":"7s"} {"level":"info","ts":"2026-03-30T16:45:54.728143Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-30T16:45:54.728318Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-30T16:45:54.728430Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-03-30T16:45:54.728597Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-30T16:45:54.728920Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-30T16:45:54.730087Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"30738c1f7233ae60","local-member-id":"22141a955455b8ec","cluster-version":"3.6"} {"level":"info","ts":"2026-03-30T16:45:54.730231Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-03-30T16:45:54.730343Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-03-30T16:45:54.730445Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-03-30T16:45:54.731097Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-03-30T16:45:54.730540Z","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-03-30T16:45:54.731222Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-03-30T16:45:54.731607Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-03-30T16:45:54.737709Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.217:2379"} {"level":"info","ts":"2026-03-30T16:45:54.738511Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-03-30T16:45:55.184029Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60660","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.184506Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60676","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.211160Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60698","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.223941Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60712","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.242482Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60752","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.258317Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60758","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.264753Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60778","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.278180Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60790","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.290668Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60808","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.300366Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60834","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.312978Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60850","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.323447Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.332963Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60896","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.343457Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60912","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.357784Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60928","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.365773Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60932","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.372169Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60936","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.378647Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60964","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.390488Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60976","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.401032Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:60992","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.410502Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32768","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.418219Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32780","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.453091Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32792","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.460428Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32808","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.468697Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32812","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.481324Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32834","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.485510Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32872","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.492280Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.499335Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32884","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.508095Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32898","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.517665Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32918","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.530810Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32942","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.541176Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32952","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.550086Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32970","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.562021Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:32998","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.574426Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33018","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.586737Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33038","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.596783Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33062","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.610845Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33084","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.623820Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33114","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.632057Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33130","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.640163Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33152","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.652955Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33164","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.659318Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33182","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.669374Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33202","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.680402Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33214","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.692337Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33220","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.699563Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33252","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.708431Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33266","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.716742Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33282","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.723701Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33306","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.730238Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33320","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.737301Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33344","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.752393Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33368","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.760959Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33382","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.767835Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33400","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.774252Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33404","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.787064Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33412","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.796689Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33430","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.823788Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33450","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.834596Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33456","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.843605Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33478","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:55.896374Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:33506","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:45:57.442748Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.54375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-30T16:45:57.442917Z","caller":"traceutil/trace.go:172","msg":"trace[1888369641] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:111; }","duration":"109.72756ms","start":"2026-03-30T16:45:57.333168Z","end":"2026-03-30T16:45:57.442896Z","steps":["trace[1888369641] 'agreement among raft nodes before linearized reading' (duration: 53.8034ms)","trace[1888369641] 'range keys from in-memory index tree' (duration: 55.70827ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:45:57.443094Z","caller":"traceutil/trace.go:172","msg":"trace[121648885] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"110.55417ms","start":"2026-03-30T16:45:57.332505Z","end":"2026-03-30T16:45:57.443060Z","steps":["trace[121648885] 'process raft request' (duration: 54.45186ms)","trace[121648885] 'compare' (duration: 55.79996ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:45:57.750714Z","caller":"traceutil/trace.go:172","msg":"trace[969612529] transaction","detail":"{read_only:false; number_of_response:0; response_revision:118; }","duration":"102.76496ms","start":"2026-03-30T16:45:57.647892Z","end":"2026-03-30T16:45:57.750657Z","steps":["trace[969612529] 'process raft request' (duration: 101.64379ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:00.612066Z","caller":"traceutil/trace.go:172","msg":"trace[1194969866] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:316; }","duration":"353.34485ms","start":"2026-03-30T16:46:00.258697Z","end":"2026-03-30T16:46:00.612042Z","steps":["trace[1194969866] 'read index received' (duration: 353.3343ms)","trace[1194969866] 'applied index is now lower than readState.Index' (duration: 8.8µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:00.612691Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"353.97608ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:00.612710Z","caller":"traceutil/trace.go:172","msg":"trace[1427244053] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:305; }","duration":"354.01385ms","start":"2026-03-30T16:46:00.258691Z","end":"2026-03-30T16:46:00.612705Z","steps":["trace[1427244053] 'agreement among raft nodes before linearized reading' (duration: 353.95208ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:00.612950Z","caller":"traceutil/trace.go:172","msg":"trace[1821166839] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"432.75772ms","start":"2026-03-30T16:46:00.180167Z","end":"2026-03-30T16:46:00.612925Z","steps":["trace[1821166839] 'process raft request' (duration: 432.58505ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:00.613490Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:00.180146Z","time spent":"432.89316ms","remote":"127.0.0.1:32774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T16:46:00.613582Z","caller":"traceutil/trace.go:172","msg":"trace[2134508594] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"108.98113ms","start":"2026-03-30T16:46:00.504594Z","end":"2026-03-30T16:46:00.613575Z","steps":["trace[2134508594] 'process raft request' (duration: 108.94934ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:00.613507Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"131.49917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:00.613750Z","caller":"traceutil/trace.go:172","msg":"trace[1453030654] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"237.12725ms","start":"2026-03-30T16:46:00.376616Z","end":"2026-03-30T16:46:00.613743Z","steps":["trace[1453030654] 'process raft request' (duration: 236.85321ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:00.613764Z","caller":"traceutil/trace.go:172","msg":"trace[1070189514] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:306; }","duration":"131.76774ms","start":"2026-03-30T16:46:00.481982Z","end":"2026-03-30T16:46:00.613749Z","steps":["trace[1070189514] 'agreement among raft nodes before linearized reading' (duration: 131.45818ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:01.289948Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"669.37535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-30T16:46:01.290037Z","caller":"traceutil/trace.go:172","msg":"trace[1493776579] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:308; }","duration":"669.46854ms","start":"2026-03-30T16:46:00.620544Z","end":"2026-03-30T16:46:01.290012Z","steps":["trace[1493776579] 'agreement among raft nodes before linearized reading' (duration: 48.74546ms)","trace[1493776579] 'range keys from in-memory index tree' (duration: 620.46631ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:01.290084Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:00.620529Z","time spent":"669.54386ms","remote":"127.0.0.1:60864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:46:01.291167Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"621.57475ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:46:01.291355Z","caller":"traceutil/trace.go:172","msg":"trace[1629130795] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"428.11564ms","start":"2026-03-30T16:46:00.863229Z","end":"2026-03-30T16:46:01.291345Z","steps":["trace[1629130795] 'process raft request' (duration: 428.09035ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:01.291348Z","caller":"traceutil/trace.go:172","msg":"trace[1520801637] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"673.30445ms","start":"2026-03-30T16:46:00.618021Z","end":"2026-03-30T16:46:01.291325Z","steps":["trace[1520801637] 'process raft request' (duration: 51.35167ms)","trace[1520801637] 'compare' (duration: 620.92349ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:01.291402Z","caller":"traceutil/trace.go:172","msg":"trace[1502503552] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"428.17302ms","start":"2026-03-30T16:46:00.863215Z","end":"2026-03-30T16:46:01.291388Z","steps":["trace[1502503552] 'process raft request' (duration: 428.05599ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:01.291411Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:00.863209Z","time spent":"428.17809ms","remote":"127.0.0.1:60990","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T16:46:01.291430Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:00.618003Z","time spent":"673.39016ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T16:46:01.291482Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:00.863183Z","time spent":"428.2557ms","remote":"127.0.0.1:60990","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T16:46:01.291385Z","caller":"traceutil/trace.go:172","msg":"trace[985001991] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:319; }","duration":"431.74446ms","start":"2026-03-30T16:46:00.859614Z","end":"2026-03-30T16:46:01.291359Z","steps":["trace[985001991] 'read index received' (duration: 46.63µs)","trace[985001991] 'applied index is now lower than readState.Index' (duration: 431.69567ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:01.291588Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"431.95491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-controller\" limit:1 ","response":"range_response_count:1 size:3461"} {"level":"info","ts":"2026-03-30T16:46:01.291632Z","caller":"traceutil/trace.go:172","msg":"trace[769531673] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-controller; range_end:; response_count:1; response_revision:309; }","duration":"432.01329ms","start":"2026-03-30T16:46:00.859609Z","end":"2026-03-30T16:46:01.291622Z","steps":["trace[769531673] 'agreement among raft nodes before linearized reading' (duration: 431.83153ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:01.291664Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:00.859585Z","time spent":"432.07009ms","remote":"127.0.0.1:60990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":3483,"request content":"key:\"/registry/pods/kube-system/kube-vip-controller\" limit:1 "} {"level":"info","ts":"2026-03-30T16:46:01.294280Z","caller":"traceutil/trace.go:172","msg":"trace[1925284305] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"430.99444ms","start":"2026-03-30T16:46:00.863266Z","end":"2026-03-30T16:46:01.294260Z","steps":["trace[1925284305] 'process raft request' (duration: 430.77536ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:01.294381Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:00.863245Z","time spent":"431.10001ms","remote":"127.0.0.1:60990","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T16:46:01.294491Z","caller":"traceutil/trace.go:172","msg":"trace[1338832303] transaction","detail":"{read_only:false; number_of_response:0; response_revision:309; }","duration":"431.04653ms","start":"2026-03-30T16:46:00.863427Z","end":"2026-03-30T16:46:01.294474Z","steps":["trace[1338832303] 'process raft request' (duration: 430.65637ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:01.294572Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:00.863421Z","time spent":"431.11516ms","remote":"127.0.0.1:60990","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T16:46:04.109300Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13325198294129277978,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T16:46:04.511794Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.13148875s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T16:46:04.512174Z","caller":"traceutil/trace.go:172","msg":"trace[2075320155] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:352; }","duration":"903.95303ms","start":"2026-03-30T16:46:03.608194Z","end":"2026-03-30T16:46:04.512147Z","steps":["trace[2075320155] 'read index received' (duration: 903.94321ms)","trace[2075320155] 'applied index is now lower than readState.Index' (duration: 7.93µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:04.684022Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.07580332s","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":"warn","ts":"2026-03-30T16:46:04.684066Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"171.79306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:46:04.684125Z","caller":"traceutil/trace.go:172","msg":"trace[2139518283] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:337; }","duration":"1.07592299s","start":"2026-03-30T16:46:03.608180Z","end":"2026-03-30T16:46:04.684103Z","steps":["trace[2139518283] 'agreement among raft nodes before linearized reading' (duration: 904.07525ms)","trace[2139518283] 'range keys from in-memory index tree' (duration: 171.62026ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:04.684171Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:03.608140Z","time spent":"1.07601939s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-03-30T16:46:04.684238Z","caller":"traceutil/trace.go:172","msg":"trace[418705368] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"1.37403659s","start":"2026-03-30T16:46:03.310185Z","end":"2026-03-30T16:46:04.684222Z","steps":["trace[418705368] 'process raft request' (duration: 1.37396595s)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:04.684231Z","caller":"traceutil/trace.go:172","msg":"trace[1394169375] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"1.803037619s","start":"2026-03-30T16:46:02.881150Z","end":"2026-03-30T16:46:04.684187Z","steps":["trace[1394169375] 'process raft request' (duration: 1.631075169s)","trace[1394169375] 'compare' (duration: 171.67659ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:04.684284Z","caller":"traceutil/trace.go:172","msg":"trace[372645261] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:352; }","duration":"172.0453ms","start":"2026-03-30T16:46:04.512226Z","end":"2026-03-30T16:46:04.684272Z","steps":["trace[372645261] 'read index received' (duration: 170.07648ms)","trace[372645261] 'applied index is now lower than readState.Index' (duration: 1.96753ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:04.684353Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:02.881114Z","time spent":"1.803179659s","remote":"127.0.0.1:32774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T16:46:04.684384Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.0408966s","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-03-30T16:46:04.684411Z","caller":"traceutil/trace.go:172","msg":"trace[1085240936] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:339; }","duration":"1.04092403s","start":"2026-03-30T16:46:03.643479Z","end":"2026-03-30T16:46:04.684403Z","steps":["trace[1085240936] 'agreement among raft nodes before linearized reading' (duration: 1.04082895s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:04.684443Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:03.643464Z","time spent":"1.04097224s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:46:04.684537Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:03.310159Z","time spent":"1.37412171s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T16:46:05.889567Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"151.12968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-03-30T16:46:05.889643Z","caller":"traceutil/trace.go:172","msg":"trace[1939461540] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:375; }","duration":"151.21665ms","start":"2026-03-30T16:46:05.738410Z","end":"2026-03-30T16:46:05.889626Z","steps":["trace[1939461540] 'agreement among raft nodes before linearized reading' (duration: 54.69475ms)","trace[1939461540] 'range keys from in-memory index tree' (duration: 96.30718ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:05.889845Z","caller":"traceutil/trace.go:172","msg":"trace[442887150] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"152.1257ms","start":"2026-03-30T16:46:05.737697Z","end":"2026-03-30T16:46:05.889822Z","steps":["trace[442887150] 'process raft request' (duration: 55.46093ms)","trace[442887150] 'compare' (duration: 96.43216ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:05.889893Z","caller":"traceutil/trace.go:172","msg":"trace[1234069036] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"151.37424ms","start":"2026-03-30T16:46:05.738456Z","end":"2026-03-30T16:46:05.889830Z","steps":["trace[1234069036] 'process raft request' (duration: 151.30048ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:06.057768Z","caller":"traceutil/trace.go:172","msg":"trace[1561981141] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"153.96192ms","start":"2026-03-30T16:46:05.903786Z","end":"2026-03-30T16:46:06.057748Z","steps":["trace[1561981141] 'process raft request' (duration: 118.17908ms)","trace[1561981141] 'compare' (duration: 35.68859ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:06.082209Z","caller":"traceutil/trace.go:172","msg":"trace[965676923] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"103.4335ms","start":"2026-03-30T16:46:05.978753Z","end":"2026-03-30T16:46:06.082186Z","steps":["trace[965676923] 'process raft request' (duration: 103.24407ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:06.082299Z","caller":"traceutil/trace.go:172","msg":"trace[1197812557] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"102.47728ms","start":"2026-03-30T16:46:05.979758Z","end":"2026-03-30T16:46:06.082235Z","steps":["trace[1197812557] 'process raft request' (duration: 102.33893ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:06.082376Z","caller":"traceutil/trace.go:172","msg":"trace[1295021370] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"101.88661ms","start":"2026-03-30T16:46:05.980463Z","end":"2026-03-30T16:46:06.082350Z","steps":["trace[1295021370] 'process raft request' (duration: 101.66781ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:06.202998Z","caller":"traceutil/trace.go:172","msg":"trace[1773078622] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"115.66989ms","start":"2026-03-30T16:46:06.087302Z","end":"2026-03-30T16:46:06.202972Z","steps":["trace[1773078622] 'process raft request' (duration: 73.14088ms)","trace[1773078622] 'compare' (duration: 42.29991ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:06.203065Z","caller":"traceutil/trace.go:172","msg":"trace[221666041] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"115.0211ms","start":"2026-03-30T16:46:06.088030Z","end":"2026-03-30T16:46:06.203051Z","steps":["trace[221666041] 'process raft request' (duration: 114.81505ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:06.203493Z","caller":"traceutil/trace.go:172","msg":"trace[819408526] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"113.424ms","start":"2026-03-30T16:46:06.090056Z","end":"2026-03-30T16:46:06.203480Z","steps":["trace[819408526] 'process raft request' (duration: 112.89671ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:06.487756Z","caller":"traceutil/trace.go:172","msg":"trace[1699645658] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"176.8254ms","start":"2026-03-30T16:46:06.310905Z","end":"2026-03-30T16:46:06.487730Z","steps":["trace[1699645658] 'process raft request' (duration: 176.65701ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:23.006904Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"147.36638ms","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-03-30T16:46:23.007612Z","caller":"traceutil/trace.go:172","msg":"trace[1574282260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:435; }","duration":"148.10648ms","start":"2026-03-30T16:46:22.859487Z","end":"2026-03-30T16:46:23.007594Z","steps":["trace[1574282260] 'agreement among raft nodes before linearized reading' (duration: 141.53912ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:23.007006Z","caller":"traceutil/trace.go:172","msg":"trace[989040984] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"177.77282ms","start":"2026-03-30T16:46:22.829205Z","end":"2026-03-30T16:46:23.006977Z","steps":["trace[989040984] 'process raft request' (duration: 171.87067ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:33.380665Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"121.78709ms","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-03-30T16:46:33.380769Z","caller":"traceutil/trace.go:172","msg":"trace[758254743] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:488; }","duration":"121.90757ms","start":"2026-03-30T16:46:33.258848Z","end":"2026-03-30T16:46:33.380756Z","steps":["trace[758254743] 'range keys from in-memory index tree' (duration: 121.70972ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:33.380918Z","caller":"traceutil/trace.go:172","msg":"trace[933677385] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"284.92941ms","start":"2026-03-30T16:46:33.095969Z","end":"2026-03-30T16:46:33.380898Z","steps":["trace[933677385] 'process raft request' (duration: 284.77847ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:33.447652Z","caller":"traceutil/trace.go:172","msg":"trace[860633705] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"350.70908ms","start":"2026-03-30T16:46:33.096919Z","end":"2026-03-30T16:46:33.447628Z","steps":["trace[860633705] 'process raft request' (duration: 350.54676ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:33.447828Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:33.096905Z","time spent":"350.83585ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T16:46:41.533451Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13325198294129278449,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T16:46:41.660318Z","caller":"traceutil/trace.go:172","msg":"trace[1948784374] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:562; }","duration":"627.12094ms","start":"2026-03-30T16:46:41.033167Z","end":"2026-03-30T16:46:41.660288Z","steps":["trace[1948784374] 'read index received' (duration: 627.11255ms)","trace[1948784374] 'applied index is now lower than readState.Index' (duration: 7.06µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:42.161380Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13325198294129278453,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T16:46:42.662620Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13325198294129278453,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T16:46:42.773269Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.112957079s","expected-duration":"1s"} {"level":"warn","ts":"2026-03-30T16:46:42.786781Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.753595379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:42.786916Z","caller":"traceutil/trace.go:172","msg":"trace[649601691] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:539; }","duration":"1.753684259s","start":"2026-03-30T16:46:41.033156Z","end":"2026-03-30T16:46:42.786840Z","steps":["trace[649601691] 'agreement among raft nodes before linearized reading' (duration: 627.24428ms)","trace[649601691] 'range keys from in-memory index tree' (duration: 1.126312469s)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:42.786983Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:41.033131Z","time spent":"1.753826739s","remote":"127.0.0.1:60818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":27,"request content":"key:\"/registry/secrets\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:46:42.786794Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.527138199s","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-03-30T16:46:42.787062Z","caller":"traceutil/trace.go:172","msg":"trace[1754731562] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:539; }","duration":"1.527414609s","start":"2026-03-30T16:46:41.259635Z","end":"2026-03-30T16:46:42.787050Z","steps":["trace[1754731562] 'range keys from in-memory index tree' (duration: 1.527104079s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:42.787366Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.126903189s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:46:42.787610Z","caller":"traceutil/trace.go:172","msg":"trace[2027590316] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.662101719s","start":"2026-03-30T16:46:41.125491Z","end":"2026-03-30T16:46:42.787592Z","steps":["trace[2027590316] 'process raft request' (duration: 1.661959259s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:42.787713Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:41.125462Z","time spent":"1.662205549s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:46:42.787849Z","caller":"traceutil/trace.go:172","msg":"trace[1807359985] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:562; }","duration":"1.127440669s","start":"2026-03-30T16:46:41.660399Z","end":"2026-03-30T16:46:42.787840Z","steps":["trace[1807359985] 'read index received' (duration: 1.113062789s)","trace[1807359985] 'applied index is now lower than readState.Index' (duration: 14.37719ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:42.787965Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.304667009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:42.787984Z","caller":"traceutil/trace.go:172","msg":"trace[674750014] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:541; }","duration":"1.304686729s","start":"2026-03-30T16:46:41.483292Z","end":"2026-03-30T16:46:42.787978Z","steps":["trace[674750014] 'agreement among raft nodes before linearized reading' (duration: 1.304649499s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:42.787998Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:41.483268Z","time spent":"1.304726919s","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T16:46:42.788165Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.379023809s","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-03-30T16:46:42.788209Z","caller":"traceutil/trace.go:172","msg":"trace[1115152307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:541; }","duration":"1.379113509s","start":"2026-03-30T16:46:41.409085Z","end":"2026-03-30T16:46:42.788198Z","steps":["trace[1115152307] 'agreement among raft nodes before linearized reading' (duration: 1.378899179s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:42.788212Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.314887579s","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":"warn","ts":"2026-03-30T16:46:42.788239Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:41.409061Z","time spent":"1.379169419s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-03-30T16:46:42.788274Z","caller":"traceutil/trace.go:172","msg":"trace[1439904014] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.783014539s","start":"2026-03-30T16:46:41.005250Z","end":"2026-03-30T16:46:42.788264Z","steps":["trace[1439904014] 'process raft request' (duration: 655.1464ms)","trace[1439904014] 'compare' (duration: 1.126351719s)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:42.788298Z","caller":"traceutil/trace.go:172","msg":"trace[503257799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:541; }","duration":"1.314949499s","start":"2026-03-30T16:46:41.473304Z","end":"2026-03-30T16:46:42.788253Z","steps":["trace[503257799] 'agreement among raft nodes before linearized reading' (duration: 1.314789119s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:42.788318Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:41.005229Z","time spent":"1.783067309s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T16:46:42.788331Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:41.473291Z","time spent":"1.315033029s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-03-30T16:46:43.300991Z","caller":"traceutil/trace.go:172","msg":"trace[187769164] transaction","detail":"{read_only:false; number_of_response:1; response_revision:556; }","duration":"101.55957ms","start":"2026-03-30T16:46:43.199419Z","end":"2026-03-30T16:46:43.300979Z","steps":["trace[187769164] 'process raft request' (duration: 101.54201ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.301096Z","caller":"traceutil/trace.go:172","msg":"trace[719327852] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"108.36991ms","start":"2026-03-30T16:46:43.192721Z","end":"2026-03-30T16:46:43.301091Z","steps":["trace[719327852] 'process raft request' (duration: 93.66219ms)","trace[719327852] 'compare' (duration: 14.30181ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:43.301182Z","caller":"traceutil/trace.go:172","msg":"trace[1064333000] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"105.73289ms","start":"2026-03-30T16:46:43.195445Z","end":"2026-03-30T16:46:43.301178Z","steps":["trace[1064333000] 'process raft request' (duration: 105.43939ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.301269Z","caller":"traceutil/trace.go:172","msg":"trace[498131946] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"104.01371ms","start":"2026-03-30T16:46:43.197251Z","end":"2026-03-30T16:46:43.301264Z","steps":["trace[498131946] 'process raft request' (duration: 103.67723ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.388051Z","caller":"traceutil/trace.go:172","msg":"trace[1404609028] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"130.98241ms","start":"2026-03-30T16:46:43.257053Z","end":"2026-03-30T16:46:43.388035Z","steps":["trace[1404609028] 'process raft request' (duration: 130.94785ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.388330Z","caller":"traceutil/trace.go:172","msg":"trace[668199665] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"151.41667ms","start":"2026-03-30T16:46:43.236903Z","end":"2026-03-30T16:46:43.388320Z","steps":["trace[668199665] 'process raft request' (duration: 150.77077ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.388418Z","caller":"traceutil/trace.go:172","msg":"trace[1103199180] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"151.42756ms","start":"2026-03-30T16:46:43.236985Z","end":"2026-03-30T16:46:43.388412Z","steps":["trace[1103199180] 'process raft request' (duration: 150.77967ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.388511Z","caller":"traceutil/trace.go:172","msg":"trace[915462357] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"132.06904ms","start":"2026-03-30T16:46:43.256436Z","end":"2026-03-30T16:46:43.388505Z","steps":["trace[915462357] 'process raft request' (duration: 131.53226ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.388525Z","caller":"traceutil/trace.go:172","msg":"trace[734940272] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"138.02457ms","start":"2026-03-30T16:46:43.250464Z","end":"2026-03-30T16:46:43.388489Z","steps":["trace[734940272] 'process raft request' (duration: 137.43623ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.388725Z","caller":"traceutil/trace.go:172","msg":"trace[824686151] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"145.73162ms","start":"2026-03-30T16:46:43.242985Z","end":"2026-03-30T16:46:43.388716Z","steps":["trace[824686151] 'process raft request' (duration: 144.82676ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.388845Z","caller":"traceutil/trace.go:172","msg":"trace[1065597031] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"143.50471ms","start":"2026-03-30T16:46:43.245328Z","end":"2026-03-30T16:46:43.388833Z","steps":["trace[1065597031] 'process raft request' (duration: 142.51591ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.388953Z","caller":"traceutil/trace.go:172","msg":"trace[2077518235] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"140.34035ms","start":"2026-03-30T16:46:43.248583Z","end":"2026-03-30T16:46:43.388923Z","steps":["trace[2077518235] 'process raft request' (duration: 139.29676ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.663048Z","caller":"traceutil/trace.go:172","msg":"trace[1388008341] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"352.39067ms","start":"2026-03-30T16:46:43.310631Z","end":"2026-03-30T16:46:43.663021Z","steps":["trace[1388008341] 'process raft request' (duration: 352.2638ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.663046Z","caller":"traceutil/trace.go:172","msg":"trace[619031221] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"359.3209ms","start":"2026-03-30T16:46:43.303694Z","end":"2026-03-30T16:46:43.663015Z","steps":["trace[619031221] 'process raft request' (duration: 260.90907ms)","trace[619031221] 'compare' (duration: 98.12053ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:43.663215Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:43.303674Z","time spent":"359.48271ms","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T16:46:43.663219Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:43.310603Z","time spent":"352.54093ms","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:46:43.663080Z","caller":"traceutil/trace.go:172","msg":"trace[1443453220] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"342.51317ms","start":"2026-03-30T16:46:43.320495Z","end":"2026-03-30T16:46:43.663009Z","steps":["trace[1443453220] 'process raft request' (duration: 342.45307ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:43.663461Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:43.320472Z","time spent":"342.90719ms","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:46:43.665680Z","caller":"traceutil/trace.go:172","msg":"trace[1305853406] transaction","detail":"{read_only:false; number_of_response:0; response_revision:567; }","duration":"273.64831ms","start":"2026-03-30T16:46:43.392000Z","end":"2026-03-30T16:46:43.665648Z","steps":["trace[1305853406] 'process raft request' (duration: 273.46008ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.665752Z","caller":"traceutil/trace.go:172","msg":"trace[985634145] transaction","detail":"{read_only:false; number_of_response:0; response_revision:567; }","duration":"273.56909ms","start":"2026-03-30T16:46:43.392163Z","end":"2026-03-30T16:46:43.665732Z","steps":["trace[985634145] 'process raft request' (duration: 273.36433ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.665842Z","caller":"traceutil/trace.go:172","msg":"trace[1840262031] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"256.25653ms","start":"2026-03-30T16:46:43.409572Z","end":"2026-03-30T16:46:43.665828Z","steps":["trace[1840262031] 'process raft request' (duration: 256.16884ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.666183Z","caller":"traceutil/trace.go:172","msg":"trace[163870494] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"263.54079ms","start":"2026-03-30T16:46:43.402627Z","end":"2026-03-30T16:46:43.666168Z","steps":["trace[163870494] 'process raft request' (duration: 262.94067ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:43.926958Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"135.00318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:46:43.927160Z","caller":"traceutil/trace.go:172","msg":"trace[360149419] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"244.90544ms","start":"2026-03-30T16:46:43.682233Z","end":"2026-03-30T16:46:43.927138Z","steps":["trace[360149419] 'process raft request' (duration: 109.61709ms)","trace[360149419] 'compare' (duration: 134.83852ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:43.927542Z","caller":"traceutil/trace.go:172","msg":"trace[1106063817] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"221.75447ms","start":"2026-03-30T16:46:43.705763Z","end":"2026-03-30T16:46:43.927517Z","steps":["trace[1106063817] 'process raft request' (duration: 221.32881ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.927621Z","caller":"traceutil/trace.go:172","msg":"trace[931247308] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"209.64926ms","start":"2026-03-30T16:46:43.717952Z","end":"2026-03-30T16:46:43.927601Z","steps":["trace[931247308] 'process raft request' (duration: 209.47953ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:43.929705Z","caller":"traceutil/trace.go:172","msg":"trace[920973720] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"198.46271ms","start":"2026-03-30T16:46:43.731220Z","end":"2026-03-30T16:46:43.929683Z","steps":["trace[920973720] 'process raft request' (duration: 198.21465ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:44.114313Z","caller":"traceutil/trace.go:172","msg":"trace[1054939549] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"170.11903ms","start":"2026-03-30T16:46:43.944175Z","end":"2026-03-30T16:46:44.114294Z","steps":["trace[1054939549] 'process raft request' (duration: 90.6083ms)","trace[1054939549] 'compare' (duration: 79.29225ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:44.129869Z","caller":"traceutil/trace.go:172","msg":"trace[1595851041] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"116.22638ms","start":"2026-03-30T16:46:44.013615Z","end":"2026-03-30T16:46:44.129842Z","steps":["trace[1595851041] 'process raft request' (duration: 116.19358ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:44.129916Z","caller":"traceutil/trace.go:172","msg":"trace[916767884] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"173.96792ms","start":"2026-03-30T16:46:43.955919Z","end":"2026-03-30T16:46:44.129887Z","steps":["trace[916767884] 'process raft request' (duration: 173.75497ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:44.530428Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"271.65735ms","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-03-30T16:46:44.530528Z","caller":"traceutil/trace.go:172","msg":"trace[1935725869] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:579; }","duration":"271.7683ms","start":"2026-03-30T16:46:44.258735Z","end":"2026-03-30T16:46:44.530503Z","steps":["trace[1935725869] 'range keys from in-memory index tree' (duration: 271.60194ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:44.530755Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.03975ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:46:44.530990Z","caller":"traceutil/trace.go:172","msg":"trace[1807521790] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"394.4025ms","start":"2026-03-30T16:46:44.136561Z","end":"2026-03-30T16:46:44.530963Z","steps":["trace[1807521790] 'process raft request' (duration: 288.07444ms)","trace[1807521790] 'compare' (duration: 105.87728ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:44.531039Z","caller":"traceutil/trace.go:172","msg":"trace[1323368116] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"354.65893ms","start":"2026-03-30T16:46:44.176363Z","end":"2026-03-30T16:46:44.531022Z","steps":["trace[1323368116] 'process raft request' (duration: 354.54979ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:44.531110Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:44.176343Z","time spent":"354.73813ms","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T16:46:44.531142Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:44.136538Z","time spent":"394.5079ms","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:46:44.549707Z","caller":"traceutil/trace.go:172","msg":"trace[1218568361] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"336.17118ms","start":"2026-03-30T16:46:44.213523Z","end":"2026-03-30T16:46:44.549694Z","steps":["trace[1218568361] 'process raft request' (duration: 336.0704ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:44.549807Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:44.213498Z","time spent":"336.26551ms","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T16:46:44.974092Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"111.79462ms","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-03-30T16:46:44.974161Z","caller":"traceutil/trace.go:172","msg":"trace[1701784929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"111.87186ms","start":"2026-03-30T16:46:44.862274Z","end":"2026-03-30T16:46:44.974146Z","steps":["trace[1701784929] 'agreement among raft nodes before linearized reading' (duration: 16.41915ms)","trace[1701784929] 'range keys from in-memory index tree' (duration: 95.3057ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:44.974501Z","caller":"traceutil/trace.go:172","msg":"trace[1783887462] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"154.72578ms","start":"2026-03-30T16:46:44.819763Z","end":"2026-03-30T16:46:44.974489Z","steps":["trace[1783887462] 'process raft request' (duration: 154.69414ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:44.974596Z","caller":"traceutil/trace.go:172","msg":"trace[1019013847] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"181.57928ms","start":"2026-03-30T16:46:44.793007Z","end":"2026-03-30T16:46:44.974586Z","steps":["trace[1019013847] 'process raft request' (duration: 85.71577ms)","trace[1019013847] 'compare' (duration: 95.10099ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:44.974755Z","caller":"traceutil/trace.go:172","msg":"trace[2119893697] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"162.91025ms","start":"2026-03-30T16:46:44.811835Z","end":"2026-03-30T16:46:44.974745Z","steps":["trace[2119893697] 'process raft request' (duration: 162.54809ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:44.974825Z","caller":"traceutil/trace.go:172","msg":"trace[2146477443] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"179.96117ms","start":"2026-03-30T16:46:44.794851Z","end":"2026-03-30T16:46:44.974813Z","steps":["trace[2146477443] 'process raft request' (duration: 179.46984ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:44.993219Z","caller":"traceutil/trace.go:172","msg":"trace[807921173] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"107.64625ms","start":"2026-03-30T16:46:44.885554Z","end":"2026-03-30T16:46:44.993201Z","steps":["trace[807921173] 'process raft request' (duration: 107.33799ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:45.364401Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"104.79026ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:45.364493Z","caller":"traceutil/trace.go:172","msg":"trace[8290397] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:605; }","duration":"104.90924ms","start":"2026-03-30T16:46:45.259564Z","end":"2026-03-30T16:46:45.364474Z","steps":["trace[8290397] 'agreement among raft nodes before linearized reading' (duration: 89.80405ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:45.364606Z","caller":"traceutil/trace.go:172","msg":"trace[1899932414] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"227.06933ms","start":"2026-03-30T16:46:45.137516Z","end":"2026-03-30T16:46:45.364585Z","steps":["trace[1899932414] 'process raft request' (duration: 227.02253ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:45.364943Z","caller":"traceutil/trace.go:172","msg":"trace[1322949433] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"233.96381ms","start":"2026-03-30T16:46:45.130967Z","end":"2026-03-30T16:46:45.364930Z","steps":["trace[1322949433] 'process raft request' (duration: 218.58864ms)","trace[1322949433] 'compare' (duration: 14.85012ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:45.384524Z","caller":"traceutil/trace.go:172","msg":"trace[1379462654] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"168.27382ms","start":"2026-03-30T16:46:45.216240Z","end":"2026-03-30T16:46:45.384514Z","steps":["trace[1379462654] 'process raft request' (duration: 168.18996ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:45.598587Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"108.68029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:46:45.598686Z","caller":"traceutil/trace.go:172","msg":"trace[1097171592] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"159.03646ms","start":"2026-03-30T16:46:45.439632Z","end":"2026-03-30T16:46:45.598669Z","steps":["trace[1097171592] 'process raft request' (duration: 50.20412ms)","trace[1097171592] 'compare' (duration: 108.55873ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:45.601100Z","caller":"traceutil/trace.go:172","msg":"trace[142252377] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"120.99102ms","start":"2026-03-30T16:46:45.480093Z","end":"2026-03-30T16:46:45.601084Z","steps":["trace[142252377] 'process raft request' (duration: 120.91614ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:45.928504Z","caller":"traceutil/trace.go:172","msg":"trace[183025137] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:640; }","duration":"250.34783ms","start":"2026-03-30T16:46:45.678131Z","end":"2026-03-30T16:46:45.928479Z","steps":["trace[183025137] 'read index received' (duration: 250.34063ms)","trace[183025137] 'applied index is now lower than readState.Index' (duration: 6.37µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:46.759848Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13325198294129278548,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T16:46:46.937263Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.259104749s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" limit:1 ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-03-30T16:46:46.937344Z","caller":"traceutil/trace.go:172","msg":"trace[568396267] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:613; }","duration":"1.259200799s","start":"2026-03-30T16:46:45.678126Z","end":"2026-03-30T16:46:46.937327Z","steps":["trace[568396267] 'agreement among raft nodes before linearized reading' (duration: 250.45344ms)","trace[568396267] 'range keys from in-memory index tree' (duration: 1.008532149s)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:46.937376Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:45.678109Z","time spent":"1.259260149s","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":1,"response size":29592,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:46:46.938997Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.009855269s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:46:46.939160Z","caller":"traceutil/trace.go:172","msg":"trace[1989774821] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.317294489s","start":"2026-03-30T16:46:45.621836Z","end":"2026-03-30T16:46:46.939131Z","steps":["trace[1989774821] 'process raft request' (duration: 306.62431ms)","trace[1989774821] 'compare' (duration: 1.009019149s)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:46.939206Z","caller":"traceutil/trace.go:172","msg":"trace[854036456] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"679.9326ms","start":"2026-03-30T16:46:46.259260Z","end":"2026-03-30T16:46:46.939193Z","steps":["trace[854036456] 'read index received' (duration: 650.46844ms)","trace[854036456] 'applied index is now lower than readState.Index' (duration: 29.46318ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:46.939278Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:45.621814Z","time spent":"1.317409199s","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T16:46:46.939283Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"680.05694ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:46.939310Z","caller":"traceutil/trace.go:172","msg":"trace[170294717] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:614; }","duration":"680.08877ms","start":"2026-03-30T16:46:46.259217Z","end":"2026-03-30T16:46:46.939306Z","steps":["trace[170294717] 'agreement among raft nodes before linearized reading' (duration: 680.0431ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:46.940481Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"459.21789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:46.940497Z","caller":"traceutil/trace.go:172","msg":"trace[111390275] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.191189059s","start":"2026-03-30T16:46:45.749298Z","end":"2026-03-30T16:46:46.940487Z","steps":["trace[111390275] 'process raft request' (duration: 1.189939209s)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:46.940548Z","caller":"traceutil/trace.go:172","msg":"trace[137899623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"459.28428ms","start":"2026-03-30T16:46:46.481249Z","end":"2026-03-30T16:46:46.940533Z","steps":["trace[137899623] 'agreement among raft nodes before linearized reading' (duration: 459.19002ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:46.940586Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:46.481231Z","time spent":"459.34755ms","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T16:46:46.940811Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:45.749272Z","time spent":"1.191279019s","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:46:49.534652Z","caller":"traceutil/trace.go:172","msg":"trace[1889210308] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"207.940229ms","start":"2026-03-30T16:46:49.326685Z","end":"2026-03-30T16:46:49.534626Z","steps":["trace[1889210308] 'process raft request' (duration: 207.307279ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:50.937288Z","caller":"traceutil/trace.go:172","msg":"trace[1914095104] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"466.34737ms","start":"2026-03-30T16:46:50.470919Z","end":"2026-03-30T16:46:50.937267Z","steps":["trace[1914095104] 'process raft request' (duration: 465.84551ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:50.937708Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:50.470894Z","time spent":"466.72271ms","remote":"127.0.0.1:60818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036189,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:46:51.141556Z","caller":"traceutil/trace.go:172","msg":"trace[882258806] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:672; }","duration":"149.26381ms","start":"2026-03-30T16:46:50.992259Z","end":"2026-03-30T16:46:51.141523Z","steps":["trace[882258806] 'read index received' (duration: 149.25321ms)","trace[882258806] 'applied index is now lower than readState.Index' (duration: 8.78µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:51.389223Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"129.75129ms","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-03-30T16:46:51.389333Z","caller":"traceutil/trace.go:172","msg":"trace[288645303] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:644; }","duration":"129.87156ms","start":"2026-03-30T16:46:51.259441Z","end":"2026-03-30T16:46:51.389312Z","steps":["trace[288645303] 'range keys from in-memory index tree' (duration: 129.68394ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:51.389368Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"247.60904ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-03-30T16:46:51.389366Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"397.08246ms","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-03-30T16:46:51.389454Z","caller":"traceutil/trace.go:172","msg":"trace[1178408674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:644; }","duration":"397.17745ms","start":"2026-03-30T16:46:50.992255Z","end":"2026-03-30T16:46:51.389432Z","steps":["trace[1178408674] 'agreement among raft nodes before linearized reading' (duration: 149.41714ms)","trace[1178408674] 'range keys from in-memory index tree' (duration: 247.53641ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:46:51.389453Z","caller":"traceutil/trace.go:172","msg":"trace[207610333] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"398.25141ms","start":"2026-03-30T16:46:50.991184Z","end":"2026-03-30T16:46:51.389436Z","steps":["trace[207610333] 'process raft request' (duration: 150.49036ms)","trace[207610333] 'compare' (duration: 247.47737ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:51.389491Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:50.992237Z","time spent":"397.24509ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:46:51.389531Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:50.991169Z","time spent":"398.32224ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T16:46:51.641773Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13325198294129278639,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T16:46:51.963557Z","caller":"traceutil/trace.go:172","msg":"trace[712213614] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:673; }","duration":"821.87695ms","start":"2026-03-30T16:46:51.141644Z","end":"2026-03-30T16:46:51.963521Z","steps":["trace[712213614] 'read index received' (duration: 821.86682ms)","trace[712213614] 'applied index is now lower than readState.Index' (duration: 8.61µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:53.414191Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.338861209s","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-03-30T16:46:53.414325Z","caller":"traceutil/trace.go:172","msg":"trace[781300610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:645; }","duration":"2.338970369s","start":"2026-03-30T16:46:51.075296Z","end":"2026-03-30T16:46:53.414266Z","steps":["trace[781300610] 'agreement among raft nodes before linearized reading' (duration: 888.35012ms)","trace[781300610] 'range keys from in-memory index tree' (duration: 1.450356619s)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:53.414380Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:51.075275Z","time spent":"2.339091579s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:46:53.414535Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.450494719s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:46:53.415006Z","caller":"traceutil/trace.go:172","msg":"trace[1153954001] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"2.021402759s","start":"2026-03-30T16:46:51.393586Z","end":"2026-03-30T16:46:53.414989Z","steps":["trace[1153954001] 'process raft request' (duration: 2.021361659s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:53.415149Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:51.393564Z","time spent":"2.021544759s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:46:53.415311Z","caller":"traceutil/trace.go:172","msg":"trace[1134303845] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"2.413651399s","start":"2026-03-30T16:46:51.001649Z","end":"2026-03-30T16:46:53.415300Z","steps":["trace[1134303845] 'process raft request' (duration: 2.413178509s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:53.415459Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:51.001639Z","time spent":"2.413777459s","remote":"127.0.0.1:60990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19197,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:46:53.415583Z","caller":"traceutil/trace.go:172","msg":"trace[1147476837] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"2.229430829s","start":"2026-03-30T16:46:51.186142Z","end":"2026-03-30T16:46:53.415573Z","steps":["trace[1147476837] 'process raft request' (duration: 2.228768359s)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:53.415677Z","caller":"traceutil/trace.go:172","msg":"trace[744726866] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:673; }","duration":"1.452021039s","start":"2026-03-30T16:46:51.963634Z","end":"2026-03-30T16:46:53.415655Z","steps":["trace[744726866] 'read index received' (duration: 156.05344ms)","trace[744726866] 'applied index is now lower than readState.Index' (duration: 1.295966799s)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:53.415706Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:51.186115Z","time spent":"2.229523259s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":528,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T16:46:53.415763Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.026375669s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:53.415797Z","caller":"traceutil/trace.go:172","msg":"trace[1956066597] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:650; }","duration":"2.026412599s","start":"2026-03-30T16:46:51.389374Z","end":"2026-03-30T16:46:53.415787Z","steps":["trace[1956066597] 'agreement among raft nodes before linearized reading' (duration: 2.026357959s)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:53.415348Z","caller":"traceutil/trace.go:172","msg":"trace[526399077] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"2.421846909s","start":"2026-03-30T16:46:50.993478Z","end":"2026-03-30T16:46:53.415325Z","steps":["trace[526399077] 'process raft request' (duration: 970.21347ms)","trace[526399077] 'compare' (duration: 1.450282239s)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:53.415877Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:50.993468Z","time spent":"2.422372689s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T16:46:53.415945Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.934010389s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:53.416042Z","caller":"traceutil/trace.go:172","msg":"trace[1118475293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"1.934108019s","start":"2026-03-30T16:46:51.481919Z","end":"2026-03-30T16:46:53.416027Z","steps":["trace[1118475293] 'agreement among raft nodes before linearized reading' (duration: 1.933921329s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:53.416119Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:51.481897Z","time spent":"1.934212119s","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T16:46:53.416387Z","caller":"traceutil/trace.go:172","msg":"trace[897298724] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"2.415639459s","start":"2026-03-30T16:46:51.000546Z","end":"2026-03-30T16:46:53.416186Z","steps":["trace[897298724] 'process raft request' (duration: 2.414161229s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:53.417643Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:51.000538Z","time spent":"2.416457599s","remote":"127.0.0.1:33046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T16:46:53.919820Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13325198294129278644,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T16:46:53.983565Z","caller":"traceutil/trace.go:172","msg":"trace[956609752] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:678; }","duration":"564.42491ms","start":"2026-03-30T16:46:53.419108Z","end":"2026-03-30T16:46:53.983533Z","steps":["trace[956609752] 'read index received' (duration: 564.41136ms)","trace[956609752] 'applied index is now lower than readState.Index' (duration: 11.87µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:54.160646Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"741.50891ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:54.160719Z","caller":"traceutil/trace.go:172","msg":"trace[293420016] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:650; }","duration":"741.59599ms","start":"2026-03-30T16:46:53.419100Z","end":"2026-03-30T16:46:54.160696Z","steps":["trace[293420016] 'agreement among raft nodes before linearized reading' (duration: 564.54942ms)","trace[293420016] 'range keys from in-memory index tree' (duration: 176.92769ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:54.161469Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"177.63869ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:46:54.161616Z","caller":"traceutil/trace.go:172","msg":"trace[844125877] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"740.77539ms","start":"2026-03-30T16:46:53.420829Z","end":"2026-03-30T16:46:54.161604Z","steps":["trace[844125877] 'process raft request' (duration: 740.71168ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:54.161659Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:53.420812Z","time spent":"740.828ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:46:54.161652Z","caller":"traceutil/trace.go:172","msg":"trace[616677078] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"767.29432ms","start":"2026-03-30T16:46:53.394339Z","end":"2026-03-30T16:46:54.161633Z","steps":["trace[616677078] 'process raft request' (duration: 589.43047ms)","trace[616677078] 'compare' (duration: 177.12136ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:54.161757Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:53.394274Z","time spent":"767.41848ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:46:54.161725Z","caller":"traceutil/trace.go:172","msg":"trace[1602068868] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"178.05754ms","start":"2026-03-30T16:46:53.983644Z","end":"2026-03-30T16:46:54.161701Z","steps":["trace[1602068868] 'read index received' (duration: 173.41937ms)","trace[1602068868] 'applied index is now lower than readState.Index' (duration: 4.63556ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:54.161795Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"735.0015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:54.162805Z","caller":"traceutil/trace.go:172","msg":"trace[2048285634] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:652; }","duration":"736.00794ms","start":"2026-03-30T16:46:53.426783Z","end":"2026-03-30T16:46:54.162791Z","steps":["trace[2048285634] 'agreement among raft nodes before linearized reading' (duration: 734.98187ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:54.162850Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:53.426767Z","time spent":"736.07218ms","remote":"127.0.0.1:33072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:46:54.161926Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"741.97208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:46:54.162994Z","caller":"traceutil/trace.go:172","msg":"trace[1759823684] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"743.05446ms","start":"2026-03-30T16:46:53.419932Z","end":"2026-03-30T16:46:54.162987Z","steps":["trace[1759823684] 'agreement among raft nodes before linearized reading' (duration: 741.87073ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:54.163016Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:46:53.419910Z","time spent":"743.10025ms","remote":"127.0.0.1:60688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T16:46:55.526938Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"107.948ms","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":"warn","ts":"2026-03-30T16:46:55.526974Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"266.92448ms","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-03-30T16:46:55.527008Z","caller":"traceutil/trace.go:172","msg":"trace[2126278091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:660; }","duration":"108.03018ms","start":"2026-03-30T16:46:55.418967Z","end":"2026-03-30T16:46:55.526998Z","steps":["trace[2126278091] 'range keys from in-memory index tree' (duration: 107.82925ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:55.527020Z","caller":"traceutil/trace.go:172","msg":"trace[2093780262] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:660; }","duration":"266.97265ms","start":"2026-03-30T16:46:55.260034Z","end":"2026-03-30T16:46:55.527007Z","steps":["trace[2093780262] 'range keys from in-memory index tree' (duration: 266.88566ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:55.527354Z","caller":"traceutil/trace.go:172","msg":"trace[519176346] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"105.94443ms","start":"2026-03-30T16:46:55.421398Z","end":"2026-03-30T16:46:55.527343Z","steps":["trace[519176346] 'process raft request' (duration: 102.45538ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:56.295469Z","caller":"traceutil/trace.go:172","msg":"trace[1119363950] linearizableReadLoop","detail":"{readStateIndex:703; appliedIndex:703; }","duration":"126.84121ms","start":"2026-03-30T16:46:56.168589Z","end":"2026-03-30T16:46:56.295430Z","steps":["trace[1119363950] 'read index received' (duration: 126.82696ms)","trace[1119363950] 'applied index is now lower than readState.Index' (duration: 12.3µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:46:56.297966Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"129.34677ms","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-03-30T16:46:56.298051Z","caller":"traceutil/trace.go:172","msg":"trace[1625431960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:674; }","duration":"129.44936ms","start":"2026-03-30T16:46:56.168585Z","end":"2026-03-30T16:46:56.298034Z","steps":["trace[1625431960] 'agreement among raft nodes before linearized reading' (duration: 126.98053ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:56.298068Z","caller":"traceutil/trace.go:172","msg":"trace[1613393162] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"129.92417ms","start":"2026-03-30T16:46:56.168108Z","end":"2026-03-30T16:46:56.298033Z","steps":["trace[1613393162] 'process raft request' (duration: 127.41883ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:46:56.303553Z","caller":"traceutil/trace.go:172","msg":"trace[909410849] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"111.89333ms","start":"2026-03-30T16:46:56.191647Z","end":"2026-03-30T16:46:56.303541Z","steps":["trace[909410849] 'process raft request' (duration: 111.84504ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:46:59.479574Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"219.92868ms","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-03-30T16:46:59.479824Z","caller":"traceutil/trace.go:172","msg":"trace[666328183] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:702; }","duration":"220.18684ms","start":"2026-03-30T16:46:59.259625Z","end":"2026-03-30T16:46:59.479812Z","steps":["trace[666328183] 'range keys from in-memory index tree' (duration: 219.87976ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:47:02.281944Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56612","server-name":"","error":"EOF"} {"level":"info","ts":"2026-03-30T16:47:04.735178Z","caller":"traceutil/trace.go:172","msg":"trace[1985541158] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:809; }","duration":"103.82826ms","start":"2026-03-30T16:47:04.631313Z","end":"2026-03-30T16:47:04.735142Z","steps":["trace[1985541158] 'read index received' (duration: 103.8158ms)","trace[1985541158] 'applied index is now lower than readState.Index' (duration: 9.82µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:47:04.774202Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"142.86707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/controller\" limit:1 ","response":"range_response_count:1 size:1501"} {"level":"info","ts":"2026-03-30T16:47:04.774275Z","caller":"traceutil/trace.go:172","msg":"trace[2061912430] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/controller; range_end:; response_count:1; response_revision:777; }","duration":"142.9478ms","start":"2026-03-30T16:47:04.631310Z","end":"2026-03-30T16:47:04.774258Z","steps":["trace[2061912430] 'agreement among raft nodes before linearized reading' (duration: 103.93972ms)","trace[2061912430] 'range keys from in-memory index tree' (duration: 38.88316ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:47:04.774503Z","caller":"traceutil/trace.go:172","msg":"trace[24532018] transaction","detail":"{read_only:false; number_of_response:0; response_revision:777; }","duration":"150.38249ms","start":"2026-03-30T16:47:04.624098Z","end":"2026-03-30T16:47:04.774481Z","steps":["trace[24532018] 'process raft request' (duration: 111.14359ms)","trace[24532018] 'compare' (duration: 39.12455ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:47:04.814175Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"171.0511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:47:04.814319Z","caller":"traceutil/trace.go:172","msg":"trace[471867168] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:777; }","duration":"171.20745ms","start":"2026-03-30T16:47:04.643093Z","end":"2026-03-30T16:47:04.814300Z","steps":["trace[471867168] 'agreement among raft nodes before linearized reading' (duration: 171.00579ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:47:04.814446Z","caller":"traceutil/trace.go:172","msg":"trace[1915866511] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"181.94121ms","start":"2026-03-30T16:47:04.632460Z","end":"2026-03-30T16:47:04.814402Z","steps":["trace[1915866511] 'process raft request' (duration: 181.59424ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:47:04.972217Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56638","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:04.993912Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56670","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.006039Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56674","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.023776Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56694","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.079178Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56724","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.105022Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56750","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.136140Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56772","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.157009Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56790","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.224667Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56810","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.253945Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56824","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.334340Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56842","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.408621Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56870","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.453634Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56892","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.470254Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56900","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.492559Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56908","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.509261Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56924","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.529712Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56942","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.545905Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56944","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.557738Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56966","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.576236Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:56970","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.595341Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57002","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.614104Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57022","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.630608Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57048","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.768188Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57052","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.779411Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57060","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.790125Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57064","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.802761Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57078","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.814228Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57114","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.827532Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57128","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.840966Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57144","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.859803Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57168","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.871360Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57194","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.884416Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57202","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:05.911923Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:57224","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-30T16:47:17.748687Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"422.69904ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T16:47:17.749293Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"488.90051ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T16:47:17.749092Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.26609573s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:47:17.749399Z","caller":"traceutil/trace.go:172","msg":"trace[1431539934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:855; }","duration":"1.26642408s","start":"2026-03-30T16:47:16.482962Z","end":"2026-03-30T16:47:17.749386Z","steps":["trace[1431539934] 'agreement among raft nodes before linearized reading' (duration: 24.25602ms)","trace[1431539934] 'range keys from in-memory index tree' (duration: 1.24180473s)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:47:17.749401Z","caller":"traceutil/trace.go:172","msg":"trace[1274103030] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:855; }","duration":"489.73694ms","start":"2026-03-30T16:47:17.259645Z","end":"2026-03-30T16:47:17.749381Z","steps":["trace[1274103030] 'range keys from in-memory index tree' (duration: 488.84084ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:47:17.749347Z","caller":"traceutil/trace.go:172","msg":"trace[678967992] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:855; }","duration":"423.39457ms","start":"2026-03-30T16:47:17.325933Z","end":"2026-03-30T16:47:17.749327Z","steps":["trace[678967992] 'range keys from in-memory index tree' (duration: 422.68175ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:47:17.749438Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:47:16.482943Z","time spent":"1.26648235s","remote":"127.0.0.1:60666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T16:47:17.749654Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.24230934s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:47:17.749776Z","caller":"traceutil/trace.go:172","msg":"trace[1664209604] linearizableReadLoop","detail":"{readStateIndex:891; appliedIndex:890; }","duration":"1.17963593s","start":"2026-03-30T16:47:16.570121Z","end":"2026-03-30T16:47:17.749757Z","steps":["trace[1664209604] 'read index received' (duration: 27.37µs)","trace[1664209604] 'applied index is now lower than readState.Index' (duration: 1.17960693s)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:47:17.749922Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.17979526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattributesclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:47:17.749966Z","caller":"traceutil/trace.go:172","msg":"trace[639789119] range","detail":"{range_begin:/registry/volumeattributesclasses; range_end:; response_count:0; response_revision:856; }","duration":"1.17983454s","start":"2026-03-30T16:47:16.570117Z","end":"2026-03-30T16:47:17.749952Z","steps":["trace[639789119] 'agreement among raft nodes before linearized reading' (duration: 1.17973861s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:47:17.750029Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:47:16.570101Z","time spent":"1.17989481s","remote":"127.0.0.1:33172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattributesclasses\" limit:1 "} {"level":"info","ts":"2026-03-30T16:47:17.749905Z","caller":"traceutil/trace.go:172","msg":"trace[844209640] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"1.32544419s","start":"2026-03-30T16:47:16.424355Z","end":"2026-03-30T16:47:17.749799Z","steps":["trace[844209640] 'process raft request' (duration: 82.89958ms)","trace[844209640] 'compare' (duration: 1.24208253s)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:47:17.750171Z","caller":"traceutil/trace.go:172","msg":"trace[1960025441] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"622.81345ms","start":"2026-03-30T16:47:17.127337Z","end":"2026-03-30T16:47:17.750151Z","steps":["trace[1960025441] 'process raft request' (duration: 622.68806ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:47:17.750344Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:47:17.127313Z","time spent":"622.94158ms","remote":"127.0.0.1:32810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2879,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T16:47:17.750849Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.15042859s","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-03-30T16:47:17.751222Z","caller":"traceutil/trace.go:172","msg":"trace[1141265510] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:857; }","duration":"1.15080022s","start":"2026-03-30T16:47:16.600406Z","end":"2026-03-30T16:47:17.751206Z","steps":["trace[1141265510] 'agreement among raft nodes before linearized reading' (duration: 1.15029667s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:47:17.751307Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:47:16.600385Z","time spent":"1.15090714s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:47:17.751475Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"234.29655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:47:17.751540Z","caller":"traceutil/trace.go:172","msg":"trace[546531872] range","detail":"{range_begin:/registry/priorityclasses; range_end:; response_count:0; response_revision:858; }","duration":"234.35962ms","start":"2026-03-30T16:47:17.517169Z","end":"2026-03-30T16:47:17.751529Z","steps":["trace[546531872] 'agreement among raft nodes before linearized reading' (duration: 234.273ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:47:17.751609Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"376.96789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:47:17.751650Z","caller":"traceutil/trace.go:172","msg":"trace[401997873] range","detail":"{range_begin:/registry/volumeattachments; range_end:; response_count:0; response_revision:858; }","duration":"377.01087ms","start":"2026-03-30T16:47:17.374629Z","end":"2026-03-30T16:47:17.751640Z","steps":["trace[401997873] 'agreement among raft nodes before linearized reading' (duration: 376.94331ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:47:17.751676Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:47:17.374587Z","time spent":"377.08246ms","remote":"127.0.0.1:33142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":31,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:47:17.750346Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:47:16.424342Z","time spent":"1.32585777s","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:47:29.947199Z","caller":"traceutil/trace.go:172","msg":"trace[1070876470] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:980; }","duration":"134.43463ms","start":"2026-03-30T16:47:29.812738Z","end":"2026-03-30T16:47:29.947173Z","steps":["trace[1070876470] 'read index received' (duration: 134.42406ms)","trace[1070876470] 'applied index is now lower than readState.Index' (duration: 9.29µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:47:29.947349Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"134.60606ms","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-03-30T16:47:29.947980Z","caller":"traceutil/trace.go:172","msg":"trace[1043102791] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:942; }","duration":"135.24403ms","start":"2026-03-30T16:47:29.812719Z","end":"2026-03-30T16:47:29.947963Z","steps":["trace[1043102791] 'agreement among raft nodes before linearized reading' (duration: 134.51303ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:47:29.947348Z","caller":"traceutil/trace.go:172","msg":"trace[2061673256] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"161.55311ms","start":"2026-03-30T16:47:29.785781Z","end":"2026-03-30T16:47:29.947334Z","steps":["trace[2061673256] 'process raft request' (duration: 161.44567ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:47:29.948048Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"124.39509ms","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-03-30T16:47:29.948168Z","caller":"traceutil/trace.go:172","msg":"trace[2021642979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:943; }","duration":"124.51293ms","start":"2026-03-30T16:47:29.823647Z","end":"2026-03-30T16:47:29.948160Z","steps":["trace[2021642979] 'agreement among raft nodes before linearized reading' (duration: 124.35957ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:47:29.948158Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"124.4739ms","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-03-30T16:47:29.948222Z","caller":"traceutil/trace.go:172","msg":"trace[1742079272] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:943; }","duration":"124.55116ms","start":"2026-03-30T16:47:29.823659Z","end":"2026-03-30T16:47:29.948210Z","steps":["trace[1742079272] 'agreement among raft nodes before linearized reading' (duration: 124.37989ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:47:42.128789Z","caller":"traceutil/trace.go:172","msg":"trace[587768145] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"141.25233ms","start":"2026-03-30T16:47:41.987510Z","end":"2026-03-30T16:47:42.128763Z","steps":["trace[587768145] 'process raft request' (duration: 141.05781ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:48:31.404889Z","caller":"traceutil/trace.go:172","msg":"trace[1269520687] linearizableReadLoop","detail":"{readStateIndex:1205; appliedIndex:1205; }","duration":"145.52812ms","start":"2026-03-30T16:48:31.259316Z","end":"2026-03-30T16:48:31.404844Z","steps":["trace[1269520687] 'read index received' (duration: 145.51684ms)","trace[1269520687] 'applied index is now lower than readState.Index' (duration: 9.8µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:48:31.405118Z","caller":"traceutil/trace.go:172","msg":"trace[604286083] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"183.89829ms","start":"2026-03-30T16:48:31.221196Z","end":"2026-03-30T16:48:31.405094Z","steps":["trace[604286083] 'process raft request' (duration: 183.72591ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:48:31.405578Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"139.91488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:48:31.405614Z","caller":"traceutil/trace.go:172","msg":"trace[698256740] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools; range_end:; response_count:0; response_revision:1156; }","duration":"139.9629ms","start":"2026-03-30T16:48:31.265642Z","end":"2026-03-30T16:48:31.405605Z","steps":["trace[698256740] 'agreement among raft nodes before linearized reading' (duration: 139.87885ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:48:31.405103Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"145.68431ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:48:31.405660Z","caller":"traceutil/trace.go:172","msg":"trace[1826243474] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1155; }","duration":"146.33098ms","start":"2026-03-30T16:48:31.259310Z","end":"2026-03-30T16:48:31.405641Z","steps":["trace[1826243474] 'agreement among raft nodes before linearized reading' (duration: 145.63954ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:48:48.972803Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13325198294129280142,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T16:48:49.174768Z","caller":"traceutil/trace.go:172","msg":"trace[1324847081] linearizableReadLoop","detail":"{readStateIndex:1261; appliedIndex:1261; }","duration":"703.07158ms","start":"2026-03-30T16:48:48.471660Z","end":"2026-03-30T16:48:49.174731Z","steps":["trace[1324847081] 'read index received' (duration: 703.0569ms)","trace[1324847081] 'applied index is now lower than readState.Index' (duration: 12.23µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:48:49.179422Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"920.13133ms","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-03-30T16:48:49.179900Z","caller":"traceutil/trace.go:172","msg":"trace[2096009575] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1208; }","duration":"920.61766ms","start":"2026-03-30T16:48:48.259273Z","end":"2026-03-30T16:48:49.179891Z","steps":["trace[2096009575] 'range keys from in-memory index tree' (duration: 920.08449ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:48:49.179575Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"707.91352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.217\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-30T16:48:49.180027Z","caller":"traceutil/trace.go:172","msg":"trace[1421049734] range","detail":"{range_begin:/registry/masterleases/199.19.213.217; range_end:; response_count:1; response_revision:1208; }","duration":"708.37829ms","start":"2026-03-30T16:48:48.471643Z","end":"2026-03-30T16:48:49.180022Z","steps":["trace[1421049734] 'agreement among raft nodes before linearized reading' (duration: 703.27541ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:48:49.180065Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:48:48.471619Z","time spent":"708.43601ms","remote":"127.0.0.1:60708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.217\" limit:1 "} {"level":"info","ts":"2026-03-30T16:48:49.180024Z","caller":"traceutil/trace.go:172","msg":"trace[1411166436] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"788.25797ms","start":"2026-03-30T16:48:48.391736Z","end":"2026-03-30T16:48:49.179994Z","steps":["trace[1411166436] 'process raft request' (duration: 783.39463ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:48:49.179934Z","caller":"traceutil/trace.go:172","msg":"trace[175521108] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"450.80465ms","start":"2026-03-30T16:48:48.729109Z","end":"2026-03-30T16:48:49.179914Z","steps":["trace[175521108] 'process raft request' (duration: 450.65792ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:48:49.180235Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"503.63595ms","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":"warn","ts":"2026-03-30T16:48:49.180327Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:48:48.729089Z","time spent":"451.15147ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T16:48:49.180323Z","caller":"traceutil/trace.go:172","msg":"trace[924161106] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1210; }","duration":"503.73491ms","start":"2026-03-30T16:48:48.676574Z","end":"2026-03-30T16:48:49.180308Z","steps":["trace[924161106] 'agreement among raft nodes before linearized reading' (duration: 503.48733ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:48:49.180409Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:48:48.676561Z","time spent":"503.81566ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:48:49.180974Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"509.63638ms","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-03-30T16:48:49.181027Z","caller":"traceutil/trace.go:172","msg":"trace[911881921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1210; }","duration":"509.70051ms","start":"2026-03-30T16:48:48.671315Z","end":"2026-03-30T16:48:49.181015Z","steps":["trace[911881921] 'agreement among raft nodes before linearized reading' (duration: 509.51858ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:48:49.181309Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:48:48.671295Z","time spent":"509.88771ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:48:49.181821Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"574.75644ms","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-03-30T16:48:49.181928Z","caller":"traceutil/trace.go:172","msg":"trace[375965509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1210; }","duration":"574.88188ms","start":"2026-03-30T16:48:48.607034Z","end":"2026-03-30T16:48:49.181916Z","steps":["trace[375965509] 'agreement among raft nodes before linearized reading' (duration: 574.58378ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:48:49.181996Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:48:48.607016Z","time spent":"574.94585ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-03-30T16:48:49.185790Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-30T16:48:48.391714Z","time spent":"788.48648ms","remote":"127.0.0.1:32858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T16:48:57.333600Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.30917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T16:48:57.334235Z","caller":"traceutil/trace.go:172","msg":"trace[1943122116] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:1237; }","duration":"101.92788ms","start":"2026-03-30T16:48:57.232264Z","end":"2026-03-30T16:48:57.334192Z","steps":["trace[1943122116] 'agreement among raft nodes before linearized reading' (duration: 60.17083ms)","trace[1943122116] 'range keys from in-memory index tree' (duration: 41.11311ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:48:57.334415Z","caller":"traceutil/trace.go:172","msg":"trace[832120740] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"109.22652ms","start":"2026-03-30T16:48:57.225164Z","end":"2026-03-30T16:48:57.334390Z","steps":["trace[832120740] 'process raft request' (duration: 67.31656ms)","trace[832120740] 'compare' (duration: 41.23483ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:48:57.334556Z","caller":"traceutil/trace.go:172","msg":"trace[603995349] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"106.69858ms","start":"2026-03-30T16:48:57.227838Z","end":"2026-03-30T16:48:57.334537Z","steps":["trace[603995349] 'process raft request' (duration: 106.57977ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:48:57.334775Z","caller":"traceutil/trace.go:172","msg":"trace[887824287] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"107.09688ms","start":"2026-03-30T16:48:57.227662Z","end":"2026-03-30T16:48:57.334759Z","steps":["trace[887824287] 'process raft request' (duration: 106.63666ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T16:49:05.576935Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"186.627839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:statefulset-controller\" limit:1 ","response":"range_response_count:1 size:1032"} {"level":"info","ts":"2026-03-30T16:49:05.577020Z","caller":"traceutil/trace.go:172","msg":"trace[1764863484] range","detail":"{range_begin:/registry/clusterroles/system:controller:statefulset-controller; range_end:; response_count:1; response_revision:1264; }","duration":"186.724849ms","start":"2026-03-30T16:49:05.390276Z","end":"2026-03-30T16:49:05.577001Z","steps":["trace[1764863484] 'agreement among raft nodes before linearized reading' (duration: 63.55296ms)","trace[1764863484] 'range keys from in-memory index tree' (duration: 122.916159ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:49:05.577190Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"123.090679ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T16:49:05.577368Z","caller":"traceutil/trace.go:172","msg":"trace[145618189] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"212.978119ms","start":"2026-03-30T16:49:05.364371Z","end":"2026-03-30T16:49:05.577349Z","steps":["trace[145618189] 'process raft request' (duration: 89.53675ms)","trace[145618189] 'compare' (duration: 122.770979ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T16:49:05.577462Z","caller":"traceutil/trace.go:172","msg":"trace[1347068394] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1321; }","duration":"109.070529ms","start":"2026-03-30T16:49:05.468375Z","end":"2026-03-30T16:49:05.577446Z","steps":["trace[1347068394] 'read index received' (duration: 108.847469ms)","trace[1347068394] 'applied index is now lower than readState.Index' (duration: 221.38µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T16:49:05.577586Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.206729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:ttl-after-finished-controller\" limit:1 ","response":"range_response_count:1 size:695"} {"level":"info","ts":"2026-03-30T16:49:05.577625Z","caller":"traceutil/trace.go:172","msg":"trace[1502562105] range","detail":"{range_begin:/registry/clusterroles/system:controller:ttl-after-finished-controller; range_end:; response_count:1; response_revision:1265; }","duration":"109.250429ms","start":"2026-03-30T16:49:05.468365Z","end":"2026-03-30T16:49:05.577615Z","steps":["trace[1502562105] 'agreement among raft nodes before linearized reading' (duration: 109.136979ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T16:49:05.578254Z","caller":"traceutil/trace.go:172","msg":"trace[223795546] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"183.552549ms","start":"2026-03-30T16:49:05.394644Z","end":"2026-03-30T16:49:05.578196Z","steps":["trace[223795546] 'process raft request' (duration: 183.383709ms)"],"step_count":1}