{"level":"warn","ts":"2026-04-19T13:29:14.768302Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-19T13:29:14.768385Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.156:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.156:2380","--initial-cluster=instance=https://199.19.213.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.156:2380","--name=instance","--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"]} {"level":"warn","ts":"2026-04-19T13:29:14.768475Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-19T13:29:14.768484Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.156:2380"]} {"level":"info","ts":"2026-04-19T13:29:14.768501Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-19T13:29:14.76911Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.156:2379"]} {"level":"info","ts":"2026-04-19T13:29:14.769182Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","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.156:2380"],"listen-peer-urls":["https://199.19.213.156:2380"],"advertise-client-urls":["https://199.19.213.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.156: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,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-19T13:29:14.773815Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.363913ms"} {"level":"info","ts":"2026-04-19T13:29:14.792159Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"163ef968c92247ab","cluster-id":"59d11c119c278888"} {"level":"info","ts":"2026-04-19T13:29:14.79229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab switched to configuration voters=()"} {"level":"info","ts":"2026-04-19T13:29:14.792322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became follower at term 0"} {"level":"info","ts":"2026-04-19T13:29:14.792346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 163ef968c92247ab [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-19T13:29:14.792362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became follower at term 1"} {"level":"info","ts":"2026-04-19T13:29:14.792467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab switched to configuration voters=(1602992745836857259)"} {"level":"warn","ts":"2026-04-19T13:29:14.819381Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-19T13:29:14.821882Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-19T13:29:14.824372Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-19T13:29:14.829147Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"163ef968c92247ab","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-19T13:29:14.829366Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"163ef968c92247ab","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-19T13:29:14.829611Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-19T13:29:14.829699Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-19T13:29:14.829714Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-19T13:29:14.833056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab switched to configuration voters=(1602992745836857259)"} {"level":"info","ts":"2026-04-19T13:29:14.833967Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"59d11c119c278888","local-member-id":"163ef968c92247ab","added-peer-id":"163ef968c92247ab","added-peer-peer-urls":["https://199.19.213.156:2380"]} {"level":"info","ts":"2026-04-19T13:29:14.835164Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-19T13:29:14.83537Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"163ef968c92247ab","initial-advertise-peer-urls":["https://199.19.213.156:2380"],"listen-peer-urls":["https://199.19.213.156:2380"],"advertise-client-urls":["https://199.19.213.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-19T13:29:14.835432Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-19T13:29:14.835538Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.156:2380"} {"level":"info","ts":"2026-04-19T13:29:14.835588Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.156:2380"} {"level":"info","ts":"2026-04-19T13:29:15.093233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab is starting a new election at term 1"} {"level":"info","ts":"2026-04-19T13:29:15.093322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became pre-candidate at term 1"} {"level":"info","ts":"2026-04-19T13:29:15.093352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab received MsgPreVoteResp from 163ef968c92247ab at term 1"} {"level":"info","ts":"2026-04-19T13:29:15.093376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became candidate at term 2"} {"level":"info","ts":"2026-04-19T13:29:15.093388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab received MsgVoteResp from 163ef968c92247ab at term 2"} {"level":"info","ts":"2026-04-19T13:29:15.093407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became leader at term 2"} {"level":"info","ts":"2026-04-19T13:29:15.093423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 163ef968c92247ab elected leader 163ef968c92247ab at term 2"} {"level":"info","ts":"2026-04-19T13:29:15.106197Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"163ef968c92247ab","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.156:2379]}","request-path":"/0/members/163ef968c92247ab/attributes","cluster-id":"59d11c119c278888","publish-timeout":"7s"} {"level":"info","ts":"2026-04-19T13:29:15.10633Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-19T13:29:15.106402Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-19T13:29:15.106483Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:29:15.106814Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-19T13:29:15.10769Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-19T13:29:15.109139Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"59d11c119c278888","local-member-id":"163ef968c92247ab","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:29:15.109389Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:29:15.109506Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:29:15.112429Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-19T13:29:15.117121Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.156:2379"} {"level":"warn","ts":"2026-04-19T13:29:43.579215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.973434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:29:43.579382Z","caller":"traceutil/trace.go:171","msg":"trace[1949851807] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"320.39798ms","start":"2026-04-19T13:29:43.258964Z","end":"2026-04-19T13:29:43.579362Z","steps":["trace[1949851807] 'process raft request' (duration: 192.748977ms)","trace[1949851807] 'compare' (duration: 125.775469ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:29:43.579458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:43.258947Z","time spent":"320.484272ms","remote":"127.0.0.1:45820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15015,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T13:29:43.582744Z","caller":"traceutil/trace.go:171","msg":"trace[1380470271] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"319.886158ms","start":"2026-04-19T13:29:43.262806Z","end":"2026-04-19T13:29:43.582693Z","steps":["trace[1380470271] 'process raft request' (duration: 318.987708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:43.582846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:43.262786Z","time spent":"320.017822ms","remote":"127.0.0.1:45734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T13:29:43.582782Z","caller":"traceutil/trace.go:171","msg":"trace[882043484] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"316.188053ms","start":"2026-04-19T13:29:43.266556Z","end":"2026-04-19T13:29:43.582744Z","steps":["trace[882043484] 'process raft request' (duration: 315.339754ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:43.582964Z","caller":"traceutil/trace.go:171","msg":"trace[1631511974] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"316.186924ms","start":"2026-04-19T13:29:43.266759Z","end":"2026-04-19T13:29:43.582946Z","steps":["trace[1631511974] 'process raft request' (duration: 315.188511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:43.583037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:43.266754Z","time spent":"316.253975ms","remote":"127.0.0.1:45820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3576,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T13:29:43.583231Z","caller":"traceutil/trace.go:171","msg":"trace[379225972] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"256.622065ms","start":"2026-04-19T13:29:43.326589Z","end":"2026-04-19T13:29:43.583211Z","steps":["trace[379225972] 'process raft request' (duration: 255.617552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:43.58341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:43.266547Z","time spent":"316.443839ms","remote":"127.0.0.1:46134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4320,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:29:45.062365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.065747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-19T13:29:45.062441Z","caller":"traceutil/trace.go:171","msg":"trace[1165338139] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:467; }","duration":"180.19259ms","start":"2026-04-19T13:29:44.882229Z","end":"2026-04-19T13:29:45.062421Z","steps":["trace[1165338139] 'range keys from in-memory index tree' (duration: 179.915103ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.527843Z","caller":"traceutil/trace.go:171","msg":"trace[353407165] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"236.096824ms","start":"2026-04-19T13:29:45.291727Z","end":"2026-04-19T13:29:45.527823Z","steps":["trace[353407165] 'process raft request' (duration: 235.9286ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.549736Z","caller":"traceutil/trace.go:171","msg":"trace[2026130285] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"251.62277ms","start":"2026-04-19T13:29:45.298057Z","end":"2026-04-19T13:29:45.549679Z","steps":["trace[2026130285] 'process raft request' (duration: 251.408585ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.549778Z","caller":"traceutil/trace.go:171","msg":"trace[657196147] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"243.669068ms","start":"2026-04-19T13:29:45.30607Z","end":"2026-04-19T13:29:45.549739Z","steps":["trace[657196147] 'process raft request' (duration: 243.471844ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.55058Z","caller":"traceutil/trace.go:171","msg":"trace[747866631] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"246.756048ms","start":"2026-04-19T13:29:45.303784Z","end":"2026-04-19T13:29:45.55054Z","steps":["trace[747866631] 'process raft request' (duration: 245.727634ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.550714Z","caller":"traceutil/trace.go:171","msg":"trace[1365959014] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"252.693305ms","start":"2026-04-19T13:29:45.298001Z","end":"2026-04-19T13:29:45.550694Z","steps":["trace[1365959014] 'process raft request' (duration: 251.389084ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.551029Z","caller":"traceutil/trace.go:171","msg":"trace[608949671] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"238.347216ms","start":"2026-04-19T13:29:45.312528Z","end":"2026-04-19T13:29:45.550876Z","steps":["trace[608949671] 'process raft request' (duration: 237.191449ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.551345Z","caller":"traceutil/trace.go:171","msg":"trace[1752704060] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"241.770904ms","start":"2026-04-19T13:29:45.309553Z","end":"2026-04-19T13:29:45.551324Z","steps":["trace[1752704060] 'process raft request' (duration: 240.014743ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.551699Z","caller":"traceutil/trace.go:171","msg":"trace[1933374782] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"228.230133ms","start":"2026-04-19T13:29:45.323385Z","end":"2026-04-19T13:29:45.551616Z","steps":["trace[1933374782] 'process raft request' (duration: 226.37441ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.551931Z","caller":"traceutil/trace.go:171","msg":"trace[1935877406] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"238.934489ms","start":"2026-04-19T13:29:45.312451Z","end":"2026-04-19T13:29:45.551385Z","steps":["trace[1935877406] 'process raft request' (duration: 237.162358ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.552004Z","caller":"traceutil/trace.go:171","msg":"trace[989200407] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"225.533151ms","start":"2026-04-19T13:29:45.326445Z","end":"2026-04-19T13:29:45.551978Z","steps":["trace[989200407] 'process raft request' (duration: 223.34743ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.556586Z","caller":"traceutil/trace.go:171","msg":"trace[2022754090] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"199.596965ms","start":"2026-04-19T13:29:45.356963Z","end":"2026-04-19T13:29:45.55656Z","steps":["trace[2022754090] 'process raft request' (duration: 193.25095ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:45.557446Z","caller":"traceutil/trace.go:171","msg":"trace[1482406021] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"108.251286ms","start":"2026-04-19T13:29:45.449179Z","end":"2026-04-19T13:29:45.55743Z","steps":["trace[1482406021] 'process raft request' (duration: 107.582801ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:46.161611Z","caller":"traceutil/trace.go:171","msg":"trace[1846233042] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"387.555524ms","start":"2026-04-19T13:29:45.774029Z","end":"2026-04-19T13:29:46.161584Z","steps":["trace[1846233042] 'process raft request' (duration: 387.36359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:46.161764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:45.774009Z","time spent":"387.678407ms","remote":"127.0.0.1:45708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:29:46.198453Z","caller":"traceutil/trace.go:171","msg":"trace[597987472] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"422.241551ms","start":"2026-04-19T13:29:45.776192Z","end":"2026-04-19T13:29:46.198433Z","steps":["trace[597987472] 'process raft request' (duration: 418.389373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:46.198604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:45.776183Z","time spent":"422.341873ms","remote":"127.0.0.1:45708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:29:46.198676Z","caller":"traceutil/trace.go:171","msg":"trace[673860328] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"397.314458ms","start":"2026-04-19T13:29:45.801336Z","end":"2026-04-19T13:29:46.19865Z","steps":["trace[673860328] 'process raft request' (duration: 396.801626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:46.198799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:45.8013Z","time spent":"397.444881ms","remote":"127.0.0.1:45708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T13:29:49.604723Z","caller":"traceutil/trace.go:171","msg":"trace[1214937525] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"770.855699ms","start":"2026-04-19T13:29:48.83384Z","end":"2026-04-19T13:29:49.604696Z","steps":["trace[1214937525] 'process raft request' (duration: 770.703476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:49.604892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:48.833782Z","time spent":"771.027693ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:29:49.655814Z","caller":"traceutil/trace.go:171","msg":"trace[1028156750] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:577; }","duration":"533.73201ms","start":"2026-04-19T13:29:49.12205Z","end":"2026-04-19T13:29:49.655782Z","steps":["trace[1028156750] 'read index received' (duration: 482.453433ms)","trace[1028156750] 'applied index is now lower than readState.Index' (duration: 51.277717ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:29:49.655821Z","caller":"traceutil/trace.go:171","msg":"trace[1392640092] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"671.557488ms","start":"2026-04-19T13:29:48.984241Z","end":"2026-04-19T13:29:49.655798Z","steps":["trace[1392640092] 'process raft request' (duration: 670.159116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:49.655985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:48.984203Z","time spent":"671.721332ms","remote":"127.0.0.1:45742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036015,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T13:29:49.656038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.974107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-19T13:29:49.656084Z","caller":"traceutil/trace.go:171","msg":"trace[1322610769] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"534.066958ms","start":"2026-04-19T13:29:49.122007Z","end":"2026-04-19T13:29:49.656074Z","steps":["trace[1322610769] 'agreement among raft nodes before linearized reading' (duration: 533.864323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:49.656115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:49.121987Z","time spent":"534.12085ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-19T13:29:49.656318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.515672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:49.657274Z","caller":"traceutil/trace.go:171","msg":"trace[333894212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"340.697776ms","start":"2026-04-19T13:29:49.315702Z","end":"2026-04-19T13:29:49.6564Z","steps":["trace[333894212] 'agreement among raft nodes before linearized reading' (duration: 340.473451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:49.657385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:49.315683Z","time spent":"341.684479ms","remote":"127.0.0.1:45676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-19T13:29:49.837946Z","caller":"traceutil/trace.go:171","msg":"trace[418603352] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"161.817398ms","start":"2026-04-19T13:29:49.676104Z","end":"2026-04-19T13:29:49.837921Z","steps":["trace[418603352] 'read index received' (duration: 128.671586ms)","trace[418603352] 'applied index is now lower than readState.Index' (duration: 33.145192ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:29:49.838059Z","caller":"traceutil/trace.go:171","msg":"trace[2062116517] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"173.192689ms","start":"2026-04-19T13:29:49.664835Z","end":"2026-04-19T13:29:49.838028Z","steps":["trace[2062116517] 'process raft request' (duration: 140.026797ms)","trace[2062116517] 'compare' (duration: 32.954247ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:29:49.838169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.040693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-19T13:29:49.838192Z","caller":"traceutil/trace.go:171","msg":"trace[79533078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:557; }","duration":"162.100254ms","start":"2026-04-19T13:29:49.676085Z","end":"2026-04-19T13:29:49.838185Z","steps":["trace[79533078] 'agreement among raft nodes before linearized reading' (duration: 161.978411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:49.838174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.190904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:49.838235Z","caller":"traceutil/trace.go:171","msg":"trace[157934664] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:557; }","duration":"111.303267ms","start":"2026-04-19T13:29:49.726913Z","end":"2026-04-19T13:29:49.838216Z","steps":["trace[157934664] 'agreement among raft nodes before linearized reading' (duration: 111.192404ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:52.981121Z","caller":"traceutil/trace.go:171","msg":"trace[1923702006] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"190.022785ms","start":"2026-04-19T13:29:52.791073Z","end":"2026-04-19T13:29:52.981096Z","steps":["trace[1923702006] 'read index received' (duration: 189.313619ms)","trace[1923702006] 'applied index is now lower than readState.Index' (duration: 708.216µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:29:52.981201Z","caller":"traceutil/trace.go:171","msg":"trace[1939642253] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"376.356826ms","start":"2026-04-19T13:29:52.604811Z","end":"2026-04-19T13:29:52.981168Z","steps":["trace[1939642253] 'process raft request' (duration: 375.795193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:52.981243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.151478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-22t67\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-19T13:29:52.981286Z","caller":"traceutil/trace.go:171","msg":"trace[1350253712] range","detail":"{range_begin:/registry/pods/kube-system/cilium-22t67; range_end:; response_count:1; response_revision:578; }","duration":"190.22785ms","start":"2026-04-19T13:29:52.791048Z","end":"2026-04-19T13:29:52.981276Z","steps":["trace[1350253712] 'agreement among raft nodes before linearized reading' (duration: 190.140358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:52.981384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:52.60479Z","time spent":"376.496769ms","remote":"127.0.0.1:45742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:29:53.488343Z","caller":"traceutil/trace.go:171","msg":"trace[874802328] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"490.241882ms","start":"2026-04-19T13:29:52.998086Z","end":"2026-04-19T13:29:53.488328Z","steps":["trace[874802328] 'process raft request' (duration: 490.12666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:53.488449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:52.998063Z","time spent":"490.330655ms","remote":"127.0.0.1:45820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:29:53.498688Z","caller":"traceutil/trace.go:171","msg":"trace[1810843883] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"451.586915ms","start":"2026-04-19T13:29:53.047064Z","end":"2026-04-19T13:29:53.498651Z","steps":["trace[1810843883] 'process raft request' (duration: 451.35982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:53.498861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:53.047041Z","time spent":"451.752098ms","remote":"127.0.0.1:46186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T13:29:53.547846Z","caller":"traceutil/trace.go:171","msg":"trace[1741300618] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"232.981862ms","start":"2026-04-19T13:29:53.314822Z","end":"2026-04-19T13:29:53.547804Z","steps":["trace[1741300618] 'read index received' (duration: 173.541617ms)","trace[1741300618] 'applied index is now lower than readState.Index' (duration: 59.438875ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:29:53.548061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.171747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:53.548131Z","caller":"traceutil/trace.go:171","msg":"trace[530072752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"233.331611ms","start":"2026-04-19T13:29:53.314783Z","end":"2026-04-19T13:29:53.548114Z","steps":["trace[530072752] 'agreement among raft nodes before linearized reading' (duration: 233.159047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:54.3489Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704522995,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-19T13:29:54.547945Z","caller":"traceutil/trace.go:171","msg":"trace[1386384748] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"928.287245ms","start":"2026-04-19T13:29:53.619632Z","end":"2026-04-19T13:29:54.547919Z","steps":["trace[1386384748] 'process raft request' (duration: 928.087681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:54.548095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:53.61959Z","time spent":"928.43107ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:29:55.19476Z","caller":"traceutil/trace.go:171","msg":"trace[776791340] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:604; }","duration":"1.346164435s","start":"2026-04-19T13:29:53.84857Z","end":"2026-04-19T13:29:55.194734Z","steps":["trace[776791340] 'read index received' (duration: 699.237463ms)","trace[776791340] 'applied index is now lower than readState.Index' (duration: 646.926082ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:29:55.194824Z","caller":"traceutil/trace.go:171","msg":"trace[897457224] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.262285358s","start":"2026-04-19T13:29:53.932506Z","end":"2026-04-19T13:29:55.194792Z","steps":["trace[897457224] 'process raft request' (duration: 1.171076153s)","trace[897457224] 'compare' (duration: 90.754755ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:29:55.194977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:53.932474Z","time spent":"1.262424812s","remote":"127.0.0.1:45742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:29:55.19511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346515064s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-19T13:29:55.195614Z","caller":"traceutil/trace.go:171","msg":"trace[191146694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"1.347044056s","start":"2026-04-19T13:29:53.848531Z","end":"2026-04-19T13:29:55.195575Z","steps":["trace[191146694] 'agreement among raft nodes before linearized reading' (duration: 1.346332549s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.195632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.201575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:29:55.195705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:53.848513Z","time spent":"1.34717335s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-19T13:29:55.195572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.746304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.195755Z","caller":"traceutil/trace.go:171","msg":"trace[1601619793] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:582; }","duration":"286.317357ms","start":"2026-04-19T13:29:54.909406Z","end":"2026-04-19T13:29:55.195724Z","steps":["trace[1601619793] 'agreement among raft nodes before linearized reading' (duration: 286.182564ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:55.195806Z","caller":"traceutil/trace.go:171","msg":"trace[516786383] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:582; }","duration":"285.99571ms","start":"2026-04-19T13:29:54.909771Z","end":"2026-04-19T13:29:55.195766Z","steps":["trace[516786383] 'agreement among raft nodes before linearized reading' (duration: 285.600452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.195839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.146782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.195891Z","caller":"traceutil/trace.go:171","msg":"trace[298096573] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:582; }","duration":"188.203044ms","start":"2026-04-19T13:29:55.007661Z","end":"2026-04-19T13:29:55.195865Z","steps":["trace[298096573] 'agreement among raft nodes before linearized reading' (duration: 188.0331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.195623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.909667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.196193Z","caller":"traceutil/trace.go:171","msg":"trace[1236990372] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:582; }","duration":"188.47459ms","start":"2026-04-19T13:29:55.007694Z","end":"2026-04-19T13:29:55.196168Z","steps":["trace[1236990372] 'agreement among raft nodes before linearized reading' (duration: 187.421215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.196233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.270163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.19627Z","caller":"traceutil/trace.go:171","msg":"trace[600186171] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"241.303614ms","start":"2026-04-19T13:29:54.954955Z","end":"2026-04-19T13:29:55.196259Z","steps":["trace[600186171] 'agreement among raft nodes before linearized reading' (duration: 241.259283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.196363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.960463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.196527Z","caller":"traceutil/trace.go:171","msg":"trace[106184857] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:582; }","duration":"287.156357ms","start":"2026-04-19T13:29:54.909354Z","end":"2026-04-19T13:29:55.19651Z","steps":["trace[106184857] 'agreement among raft nodes before linearized reading' (duration: 286.784179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.19654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.548563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.196568Z","caller":"traceutil/trace.go:171","msg":"trace[8970187] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"242.616174ms","start":"2026-04-19T13:29:54.953945Z","end":"2026-04-19T13:29:55.196561Z","steps":["trace[8970187] 'agreement among raft nodes before linearized reading' (duration: 242.579254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.195579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.837728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:29:55.196815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.933302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.196842Z","caller":"traceutil/trace.go:171","msg":"trace[133166407] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:582; }","duration":"242.976452ms","start":"2026-04-19T13:29:54.953851Z","end":"2026-04-19T13:29:55.196827Z","steps":["trace[133166407] 'agreement among raft nodes before linearized reading' (duration: 242.944942ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:55.196858Z","caller":"traceutil/trace.go:171","msg":"trace[850749266] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:582; }","duration":"264.130778ms","start":"2026-04-19T13:29:54.932695Z","end":"2026-04-19T13:29:55.196826Z","steps":["trace[850749266] 'agreement among raft nodes before linearized reading' (duration: 262.375768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.197002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.197031Z","caller":"traceutil/trace.go:171","msg":"trace[357081733] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:582; }","duration":"263.832191ms","start":"2026-04-19T13:29:54.933186Z","end":"2026-04-19T13:29:55.197018Z","steps":["trace[357081733] 'agreement among raft nodes before linearized reading' (duration: 263.752519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.197112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.161099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:29:55.19725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.468616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.197279Z","caller":"traceutil/trace.go:171","msg":"trace[1830923111] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:582; }","duration":"264.518496ms","start":"2026-04-19T13:29:54.932748Z","end":"2026-04-19T13:29:55.197266Z","steps":["trace[1830923111] 'agreement among raft nodes before linearized reading' (duration: 264.454735ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:55.197265Z","caller":"traceutil/trace.go:171","msg":"trace[353498604] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:582; }","duration":"382.296012ms","start":"2026-04-19T13:29:54.814884Z","end":"2026-04-19T13:29:55.19718Z","steps":["trace[353498604] 'agreement among raft nodes before linearized reading' (duration: 381.803181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.197431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.814865Z","time spent":"382.516987ms","remote":"127.0.0.1:33604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-19T13:29:55.19779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.343392872s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-19T13:29:55.197922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.535807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.197959Z","caller":"traceutil/trace.go:171","msg":"trace[187411482] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:582; }","duration":"153.595519ms","start":"2026-04-19T13:29:55.044356Z","end":"2026-04-19T13:29:55.197952Z","steps":["trace[187411482] 'agreement among raft nodes before linearized reading' (duration: 153.544457ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:55.197911Z","caller":"traceutil/trace.go:171","msg":"trace[1539912844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"1.343510554s","start":"2026-04-19T13:29:53.854366Z","end":"2026-04-19T13:29:55.197877Z","steps":["trace[1539912844] 'agreement among raft nodes before linearized reading' (duration: 1.34070654s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.198068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.6763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.198102Z","caller":"traceutil/trace.go:171","msg":"trace[1013511789] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:582; }","duration":"153.734302ms","start":"2026-04-19T13:29:55.044361Z","end":"2026-04-19T13:29:55.198096Z","steps":["trace[1013511789] 'agreement among raft nodes before linearized reading' (duration: 153.686971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.198044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:53.85436Z","time spent":"1.343669499s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-19T13:29:55.198022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.372128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.198208Z","caller":"traceutil/trace.go:171","msg":"trace[898082139] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:582; }","duration":"383.610363ms","start":"2026-04-19T13:29:54.81459Z","end":"2026-04-19T13:29:55.1982Z","steps":["trace[898082139] 'agreement among raft nodes before linearized reading' (duration: 383.367978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.198237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.814564Z","time spent":"383.658724ms","remote":"127.0.0.1:33604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-19T13:29:55.198249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.040666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.198326Z","caller":"traceutil/trace.go:171","msg":"trace[915270750] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:582; }","duration":"405.129377ms","start":"2026-04-19T13:29:54.793147Z","end":"2026-04-19T13:29:55.198276Z","steps":["trace[915270750] 'agreement among raft nodes before linearized reading' (duration: 405.026785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.198397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.793115Z","time spent":"405.24709ms","remote":"127.0.0.1:33598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-04-19T13:29:55.198137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.622194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.198497Z","caller":"traceutil/trace.go:171","msg":"trace[137388996] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:582; }","duration":"383.982942ms","start":"2026-04-19T13:29:54.814502Z","end":"2026-04-19T13:29:55.198485Z","steps":["trace[137388996] 'agreement among raft nodes before linearized reading' (duration: 383.583753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.198524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.814438Z","time spent":"384.077403ms","remote":"127.0.0.1:33604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-19T13:29:55.198701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.391794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.198723Z","caller":"traceutil/trace.go:171","msg":"trace[162922446] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:582; }","duration":"190.443045ms","start":"2026-04-19T13:29:55.008273Z","end":"2026-04-19T13:29:55.198716Z","steps":["trace[162922446] 'agreement among raft nodes before linearized reading' (duration: 190.400494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.19878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.215116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:29:55.195674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.444926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.198857Z","caller":"traceutil/trace.go:171","msg":"trace[1131317290] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:582; }","duration":"153.63282ms","start":"2026-04-19T13:29:55.045214Z","end":"2026-04-19T13:29:55.198847Z","steps":["trace[1131317290] 'agreement among raft nodes before linearized reading' (duration: 149.916574ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:55.198875Z","caller":"traceutil/trace.go:171","msg":"trace[1517952249] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:582; }","duration":"407.344008ms","start":"2026-04-19T13:29:54.791515Z","end":"2026-04-19T13:29:55.198859Z","steps":["trace[1517952249] 'agreement among raft nodes before linearized reading' (duration: 407.169554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.198874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.910673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:29:55.198958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.791502Z","time spent":"407.440361ms","remote":"127.0.0.1:33598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"info","ts":"2026-04-19T13:29:55.198985Z","caller":"traceutil/trace.go:171","msg":"trace[1087383122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"883.025246ms","start":"2026-04-19T13:29:54.315911Z","end":"2026-04-19T13:29:55.198936Z","steps":["trace[1087383122] 'agreement among raft nodes before linearized reading' (duration: 882.888273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.199034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.799868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:29:55.198896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.341259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.199088Z","caller":"traceutil/trace.go:171","msg":"trace[390221370] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:582; }","duration":"407.560893ms","start":"2026-04-19T13:29:54.791514Z","end":"2026-04-19T13:29:55.199075Z","steps":["trace[390221370] 'agreement among raft nodes before linearized reading' (duration: 407.347768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.199037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.315893Z","time spent":"883.133748ms","remote":"127.0.0.1:45676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-19T13:29:55.199097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.567423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:29:55.199147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.791497Z","time spent":"407.627135ms","remote":"127.0.0.1:33598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-04-19T13:29:55.199192Z","caller":"traceutil/trace.go:171","msg":"trace[1103396088] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:582; }","duration":"427.943512ms","start":"2026-04-19T13:29:54.771222Z","end":"2026-04-19T13:29:55.199165Z","steps":["trace[1103396088] 'agreement among raft nodes before linearized reading' (duration: 427.531743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.199216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.86619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-19T13:29:55.199272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.771174Z","time spent":"428.056675ms","remote":"127.0.0.1:33596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-19T13:29:55.198971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.291727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:29:55.199573Z","caller":"traceutil/trace.go:171","msg":"trace[967225618] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:582; }","duration":"427.912181ms","start":"2026-04-19T13:29:54.771646Z","end":"2026-04-19T13:29:55.199558Z","steps":["trace[967225618] 'agreement among raft nodes before linearized reading' (duration: 427.282507ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:29:55.199098Z","caller":"traceutil/trace.go:171","msg":"trace[566730850] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:582; }","duration":"427.88835ms","start":"2026-04-19T13:29:54.771183Z","end":"2026-04-19T13:29:55.199071Z","steps":["trace[566730850] 'agreement among raft nodes before linearized reading' (duration: 427.809938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.199631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.771638Z","time spent":"427.964472ms","remote":"127.0.0.1:33596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-19T13:29:55.199639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.771164Z","time spent":"428.459153ms","remote":"127.0.0.1:33596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-19T13:29:55.19925Z","caller":"traceutil/trace.go:171","msg":"trace[1487805057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:582; }","duration":"592.925322ms","start":"2026-04-19T13:29:54.60631Z","end":"2026-04-19T13:29:55.199235Z","steps":["trace[1487805057] 'agreement among raft nodes before linearized reading' (duration: 592.85308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:29:55.199743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:29:54.606292Z","time spent":"593.438953ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-19T13:30:07.457744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.817687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-19T13:30:07.457814Z","caller":"traceutil/trace.go:171","msg":"trace[1279414015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:725; }","duration":"194.934369ms","start":"2026-04-19T13:30:07.262867Z","end":"2026-04-19T13:30:07.457801Z","steps":["trace[1279414015] 'range keys from in-memory index tree' (duration: 194.702774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:07.457851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.109262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-19T13:30:07.457898Z","caller":"traceutil/trace.go:171","msg":"trace[494605716] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:725; }","duration":"198.177863ms","start":"2026-04-19T13:30:07.259708Z","end":"2026-04-19T13:30:07.457886Z","steps":["trace[494605716] 'range keys from in-memory index tree' (duration: 197.855306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:07.457749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.663057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-19T13:30:07.458057Z","caller":"traceutil/trace.go:171","msg":"trace[881907642] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:725; }","duration":"199.994644ms","start":"2026-04-19T13:30:07.258023Z","end":"2026-04-19T13:30:07.458018Z","steps":["trace[881907642] 'range keys from in-memory index tree' (duration: 199.544864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:07.458502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.75637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:30:07.458613Z","caller":"traceutil/trace.go:171","msg":"trace[85416275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:725; }","duration":"142.890292ms","start":"2026-04-19T13:30:07.315698Z","end":"2026-04-19T13:30:07.458589Z","steps":["trace[85416275] 'range keys from in-memory index tree' (duration: 142.689248ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:30:07.616549Z","caller":"traceutil/trace.go:171","msg":"trace[1689310937] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"154.546201ms","start":"2026-04-19T13:30:07.461987Z","end":"2026-04-19T13:30:07.616533Z","steps":["trace[1689310937] 'process raft request' (duration: 154.431348ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:30:07.619443Z","caller":"traceutil/trace.go:171","msg":"trace[616673139] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"108.236607ms","start":"2026-04-19T13:30:07.511196Z","end":"2026-04-19T13:30:07.619432Z","steps":["trace[616673139] 'process raft request' (duration: 108.192266ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:30:07.619687Z","caller":"traceutil/trace.go:171","msg":"trace[487503954] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"156.744091ms","start":"2026-04-19T13:30:07.462745Z","end":"2026-04-19T13:30:07.619489Z","steps":["trace[487503954] 'process raft request' (duration: 156.610628ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:30:07.619696Z","caller":"traceutil/trace.go:171","msg":"trace[1452756904] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"156.859614ms","start":"2026-04-19T13:30:07.462614Z","end":"2026-04-19T13:30:07.619474Z","steps":["trace[1452756904] 'process raft request' (duration: 156.68974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:12.136395Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704523351,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-19T13:30:12.368844Z","caller":"traceutil/trace.go:171","msg":"trace[1066966643] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:775; }","duration":"733.042991ms","start":"2026-04-19T13:30:11.635772Z","end":"2026-04-19T13:30:12.368815Z","steps":["trace[1066966643] 'read index received' (duration: 732.864157ms)","trace[1066966643] 'applied index is now lower than readState.Index' (duration: 177.644µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:30:12.369218Z","caller":"traceutil/trace.go:171","msg":"trace[1208556363] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"735.433815ms","start":"2026-04-19T13:30:11.633747Z","end":"2026-04-19T13:30:12.369181Z","steps":["trace[1208556363] 'process raft request' (duration: 734.893613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:12.369295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.501061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-19T13:30:12.369346Z","caller":"traceutil/trace.go:171","msg":"trace[24733259] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:748; }","duration":"733.606274ms","start":"2026-04-19T13:30:11.635731Z","end":"2026-04-19T13:30:12.369337Z","steps":["trace[24733259] 'agreement among raft nodes before linearized reading' (duration: 733.412769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:12.369356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:11.633724Z","time spent":"735.569918ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:30:12.369375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:11.635719Z","time spent":"733.647864ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-19T13:30:12.507783Z","caller":"traceutil/trace.go:171","msg":"trace[629064104] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:776; }","duration":"138.84209ms","start":"2026-04-19T13:30:12.36892Z","end":"2026-04-19T13:30:12.507762Z","steps":["trace[629064104] 'read index received' (duration: 136.602169ms)","trace[629064104] 'applied index is now lower than readState.Index' (duration: 2.238981ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:30:12.507874Z","caller":"traceutil/trace.go:171","msg":"trace[1109782402] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"321.201749ms","start":"2026-04-19T13:30:12.186653Z","end":"2026-04-19T13:30:12.507855Z","steps":["trace[1109782402] 'process raft request' (duration: 318.684272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:12.508022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.960579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:30:12.508117Z","caller":"traceutil/trace.go:171","msg":"trace[101243979] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:749; }","duration":"195.074422ms","start":"2026-04-19T13:30:12.313023Z","end":"2026-04-19T13:30:12.508097Z","steps":["trace[101243979] 'agreement among raft nodes before linearized reading' (duration: 194.886848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:12.508127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:12.186628Z","time spent":"321.390093ms","remote":"127.0.0.1:45892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:30:12.508085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.276589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:30:12.508794Z","caller":"traceutil/trace.go:171","msg":"trace[25716121] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:749; }","duration":"873.017176ms","start":"2026-04-19T13:30:11.635762Z","end":"2026-04-19T13:30:12.508779Z","steps":["trace[25716121] 'agreement among raft nodes before linearized reading' (duration: 872.148327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:12.508894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:11.635747Z","time spent":"873.132909ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-19T13:30:12.552431Z","caller":"traceutil/trace.go:171","msg":"trace[1610064901] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"178.911609ms","start":"2026-04-19T13:30:12.373485Z","end":"2026-04-19T13:30:12.552397Z","steps":["trace[1610064901] 'process raft request' (duration: 178.621362ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:30:47.589947Z","caller":"traceutil/trace.go:171","msg":"trace[387426944] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"249.485039ms","start":"2026-04-19T13:30:47.340426Z","end":"2026-04-19T13:30:47.589911Z","steps":["trace[387426944] 'process raft request' (duration: 249.243313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:48.513708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:48.111561Z","time spent":"402.139198ms","remote":"127.0.0.1:45692","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-19T13:30:49.044121Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704523822,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-19T13:30:49.319777Z","caller":"traceutil/trace.go:171","msg":"trace[1766564644] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"805.107113ms","start":"2026-04-19T13:30:48.514638Z","end":"2026-04-19T13:30:49.319745Z","steps":["trace[1766564644] 'process raft request' (duration: 803.715401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:49.319945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:48.514622Z","time spent":"805.238516ms","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:30:49.320048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.958168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-19T13:30:49.320104Z","caller":"traceutil/trace.go:171","msg":"trace[698076452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:966; }","duration":"777.05694ms","start":"2026-04-19T13:30:48.543035Z","end":"2026-04-19T13:30:49.320092Z","steps":["trace[698076452] 'agreement among raft nodes before linearized reading' (duration: 776.844375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:49.320139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:48.54302Z","time spent":"777.110891ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-19T13:30:49.319823Z","caller":"traceutil/trace.go:171","msg":"trace[1916873012] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1004; }","duration":"776.680661ms","start":"2026-04-19T13:30:48.543077Z","end":"2026-04-19T13:30:49.319758Z","steps":["trace[1916873012] 'read index received' (duration: 775.231588ms)","trace[1916873012] 'applied index is now lower than readState.Index' (duration: 1.446493ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:30:49.32062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.140394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-19T13:30:49.320655Z","caller":"traceutil/trace.go:171","msg":"trace[448565024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:966; }","duration":"521.187316ms","start":"2026-04-19T13:30:48.799459Z","end":"2026-04-19T13:30:49.320646Z","steps":["trace[448565024] 'agreement among raft nodes before linearized reading' (duration: 521.101334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:49.320676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:48.799453Z","time spent":"521.219037ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-19T13:30:49.320687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.497123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-19T13:30:49.32075Z","caller":"traceutil/trace.go:171","msg":"trace[1475861915] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:966; }","duration":"425.572515ms","start":"2026-04-19T13:30:48.895161Z","end":"2026-04-19T13:30:49.320734Z","steps":["trace[1475861915] 'agreement among raft nodes before linearized reading' (duration: 425.369521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:49.320791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:48.895131Z","time spent":"425.651886ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-19T13:30:49.320766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.47239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-19T13:30:49.3208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.168824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:30:49.320835Z","caller":"traceutil/trace.go:171","msg":"trace[2098412342] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:966; }","duration":"609.540511ms","start":"2026-04-19T13:30:48.711282Z","end":"2026-04-19T13:30:49.320823Z","steps":["trace[2098412342] 'agreement among raft nodes before linearized reading' (duration: 609.211654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:49.320869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:48.711219Z","time spent":"609.642294ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-19T13:30:49.320868Z","caller":"traceutil/trace.go:171","msg":"trace[1143940854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:966; }","duration":"606.245036ms","start":"2026-04-19T13:30:48.714599Z","end":"2026-04-19T13:30:49.320844Z","steps":["trace[1143940854] 'agreement among raft nodes before linearized reading' (duration: 605.99866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:30:49.320918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:30:48.714593Z","time spent":"606.315717ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-19T13:30:59.515987Z","caller":"traceutil/trace.go:171","msg":"trace[364704052] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"107.897034ms","start":"2026-04-19T13:30:59.408063Z","end":"2026-04-19T13:30:59.51596Z","steps":["trace[364704052] 'process raft request' (duration: 58.362178ms)","trace[364704052] 'compare' (duration: 49.380212ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:30:59.516325Z","caller":"traceutil/trace.go:171","msg":"trace[470656976] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"107.496173ms","start":"2026-04-19T13:30:59.408795Z","end":"2026-04-19T13:30:59.51629Z","steps":["trace[470656976] 'process raft request' (duration: 107.124875ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:30:59.516352Z","caller":"traceutil/trace.go:171","msg":"trace[1953487312] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"106.286786ms","start":"2026-04-19T13:30:59.410053Z","end":"2026-04-19T13:30:59.51634Z","steps":["trace[1953487312] 'process raft request' (duration: 106.01688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:08.342888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.375938ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:31:08.343067Z","caller":"traceutil/trace.go:171","msg":"trace[221447292] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"177.986651ms","start":"2026-04-19T13:31:08.165049Z","end":"2026-04-19T13:31:08.343036Z","steps":["trace[221447292] 'process raft request' (duration: 37.400548ms)","trace[221447292] 'compare' (duration: 140.235545ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:09.632526Z","caller":"traceutil/trace.go:171","msg":"trace[1496003896] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"185.644085ms","start":"2026-04-19T13:31:09.446864Z","end":"2026-04-19T13:31:09.632508Z","steps":["trace[1496003896] 'process raft request' (duration: 185.502391ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:09.757569Z","caller":"traceutil/trace.go:171","msg":"trace[873252943] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"121.082715ms","start":"2026-04-19T13:31:09.636456Z","end":"2026-04-19T13:31:09.757538Z","steps":["trace[873252943] 'process raft request' (duration: 48.0224ms)","trace[873252943] 'compare' (duration: 72.757298ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:09.757714Z","caller":"traceutil/trace.go:171","msg":"trace[311639794] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"119.963419ms","start":"2026-04-19T13:31:09.637734Z","end":"2026-04-19T13:31:09.757697Z","steps":["trace[311639794] 'process raft request' (duration: 119.881867ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:09.757726Z","caller":"traceutil/trace.go:171","msg":"trace[117860730] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"120.343388ms","start":"2026-04-19T13:31:09.637355Z","end":"2026-04-19T13:31:09.757699Z","steps":["trace[117860730] 'process raft request' (duration: 120.166024ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:09.757584Z","caller":"traceutil/trace.go:171","msg":"trace[472028733] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"121.103945ms","start":"2026-04-19T13:31:09.636454Z","end":"2026-04-19T13:31:09.757558Z","steps":["trace[472028733] 'process raft request' (duration: 120.984702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:10.061354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.347386ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:31:10.061458Z","caller":"traceutil/trace.go:171","msg":"trace[159984684] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"315.936091ms","start":"2026-04-19T13:31:09.745503Z","end":"2026-04-19T13:31:10.061439Z","steps":["trace[159984684] 'process raft request' (duration: 134.415232ms)","trace[159984684] 'compare' (duration: 181.188941ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:10.061514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:09.745479Z","time spent":"316.008022ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:31:12.263301Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704524012,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T13:31:12.763709Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704524012,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T13:31:13.264858Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704524012,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T13:31:13.765847Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704524012,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T13:31:13.965639Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.324766384s","expected-duration":"1s"} {"level":"info","ts":"2026-04-19T13:31:13.966168Z","caller":"traceutil/trace.go:171","msg":"trace[1003601814] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"2.325386737s","start":"2026-04-19T13:31:11.640752Z","end":"2026-04-19T13:31:13.966139Z","steps":["trace[1003601814] 'process raft request' (duration: 2.325200793s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:13.966378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:11.640733Z","time spent":"2.325562722s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:31:13.977498Z","caller":"traceutil/trace.go:171","msg":"trace[1016249110] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"1.909605117s","start":"2026-04-19T13:31:12.067873Z","end":"2026-04-19T13:31:13.977478Z","steps":["trace[1016249110] 'process raft request' (duration: 1.906822203s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:13.977658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:12.06785Z","time spent":"1.909707199s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:31:13.977756Z","caller":"traceutil/trace.go:171","msg":"trace[1285822914] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"1.69159506s","start":"2026-04-19T13:31:12.28614Z","end":"2026-04-19T13:31:13.977735Z","steps":["trace[1285822914] 'process raft request' (duration: 1.691285563s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:13.977922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:12.286112Z","time spent":"1.691701483s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:31:14.033416Z","caller":"traceutil/trace.go:171","msg":"trace[1239964387] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1081; }","duration":"2.271011101s","start":"2026-04-19T13:31:11.762383Z","end":"2026-04-19T13:31:14.033394Z","steps":["trace[1239964387] 'read index received' (duration: 2.203537834s)","trace[1239964387] 'applied index is now lower than readState.Index' (duration: 67.472067ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:14.033678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.718431655s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:31:14.033695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.514109652s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:14.033778Z","caller":"traceutil/trace.go:171","msg":"trace[2041516507] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1041; }","duration":"1.514255765s","start":"2026-04-19T13:31:12.519505Z","end":"2026-04-19T13:31:14.033761Z","steps":["trace[2041516507] 'agreement among raft nodes before linearized reading' (duration: 1.514109612s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:14.033805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.270602452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-19T13:31:14.033675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.271278488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-19T13:31:14.033846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.271082543s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-19T13:31:14.033837Z","caller":"traceutil/trace.go:171","msg":"trace[827658682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1041; }","duration":"2.270647093s","start":"2026-04-19T13:31:11.76318Z","end":"2026-04-19T13:31:14.033827Z","steps":["trace[827658682] 'agreement among raft nodes before linearized reading' (duration: 2.270495449s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:14.033877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:11.763172Z","time spent":"2.270696985s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-19T13:31:14.033898Z","caller":"traceutil/trace.go:171","msg":"trace[182385289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1041; }","duration":"2.271115773s","start":"2026-04-19T13:31:11.762744Z","end":"2026-04-19T13:31:14.033859Z","steps":["trace[182385289] 'agreement among raft nodes before linearized reading' (duration: 2.2709619s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:14.033879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.271147204s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-19T13:31:14.033915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:11.762738Z","time spent":"2.271172124s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-19T13:31:14.033878Z","caller":"traceutil/trace.go:171","msg":"trace[1246906717] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1041; }","duration":"2.271520102s","start":"2026-04-19T13:31:11.762339Z","end":"2026-04-19T13:31:14.033859Z","steps":["trace[1246906717] 'agreement among raft nodes before linearized reading' (duration: 2.271172924s)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:14.033732Z","caller":"traceutil/trace.go:171","msg":"trace[8881195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1041; }","duration":"1.718488926s","start":"2026-04-19T13:31:12.315232Z","end":"2026-04-19T13:31:14.033721Z","steps":["trace[8881195] 'agreement among raft nodes before linearized reading' (duration: 1.718371484s)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:14.033973Z","caller":"traceutil/trace.go:171","msg":"trace[153721319] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1041; }","duration":"2.271238457s","start":"2026-04-19T13:31:11.762685Z","end":"2026-04-19T13:31:14.033924Z","steps":["trace[153721319] 'agreement among raft nodes before linearized reading' (duration: 2.270840978s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:14.034004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:12.315201Z","time spent":"1.718798193s","remote":"127.0.0.1:45676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-19T13:31:14.034016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:11.762322Z","time spent":"2.271680957s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-19T13:31:14.034024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:11.762671Z","time spent":"2.271338689s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-19T13:31:14.033826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:12.519484Z","time spent":"1.514331127s","remote":"127.0.0.1:33690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-19T13:31:14.033679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.148107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:14.034212Z","caller":"traceutil/trace.go:171","msg":"trace[1286792154] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1041; }","duration":"214.795523ms","start":"2026-04-19T13:31:13.819407Z","end":"2026-04-19T13:31:14.034202Z","steps":["trace[1286792154] 'agreement among raft nodes before linearized reading' (duration: 214.161478ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:14.253882Z","caller":"traceutil/trace.go:171","msg":"trace[392421337] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"213.973964ms","start":"2026-04-19T13:31:14.039859Z","end":"2026-04-19T13:31:14.253833Z","steps":["trace[392421337] 'process raft request' (duration: 213.896742ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:14.253901Z","caller":"traceutil/trace.go:171","msg":"trace[16081744] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"214.479557ms","start":"2026-04-19T13:31:14.039387Z","end":"2026-04-19T13:31:14.253867Z","steps":["trace[16081744] 'process raft request' (duration: 214.21062ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:14.254292Z","caller":"traceutil/trace.go:171","msg":"trace[913879907] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1085; }","duration":"212.384958ms","start":"2026-04-19T13:31:14.041893Z","end":"2026-04-19T13:31:14.254278Z","steps":["trace[913879907] 'read index received' (duration: 39.570036ms)","trace[913879907] 'applied index is now lower than readState.Index' (duration: 172.813602ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:14.254376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.463861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:14.25437Z","caller":"traceutil/trace.go:171","msg":"trace[1913864302] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"214.395353ms","start":"2026-04-19T13:31:14.039949Z","end":"2026-04-19T13:31:14.254345Z","steps":["trace[1913864302] 'process raft request' (duration: 213.848341ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:14.254406Z","caller":"traceutil/trace.go:171","msg":"trace[1907090490] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1045; }","duration":"212.535342ms","start":"2026-04-19T13:31:14.041861Z","end":"2026-04-19T13:31:14.254396Z","steps":["trace[1907090490] 'agreement among raft nodes before linearized reading' (duration: 212.4668ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:16.094475Z","caller":"traceutil/trace.go:171","msg":"trace[167669940] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"119.98246ms","start":"2026-04-19T13:31:15.974468Z","end":"2026-04-19T13:31:16.094451Z","steps":["trace[167669940] 'process raft request' (duration: 119.841937ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:16.117542Z","caller":"traceutil/trace.go:171","msg":"trace[34352456] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"135.567727ms","start":"2026-04-19T13:31:15.981945Z","end":"2026-04-19T13:31:16.117513Z","steps":["trace[34352456] 'process raft request' (duration: 135.229439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:16.758413Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704524033,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T13:31:16.990302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.721984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:31:16.990448Z","caller":"traceutil/trace.go:171","msg":"trace[172160793] linearizableReadLoop","detail":"{readStateIndex:1092; appliedIndex:1091; }","duration":"732.121262ms","start":"2026-04-19T13:31:16.258304Z","end":"2026-04-19T13:31:16.990426Z","steps":["trace[172160793] 'read index received' (duration: 568.076601ms)","trace[172160793] 'applied index is now lower than readState.Index' (duration: 164.042891ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:16.990767Z","caller":"traceutil/trace.go:171","msg":"trace[1160926804] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"869.302104ms","start":"2026-04-19T13:31:16.121418Z","end":"2026-04-19T13:31:16.99072Z","steps":["trace[1160926804] 'process raft request' (duration: 705.026478ms)","trace[1160926804] 'compare' (duration: 162.950865ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:16.990943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.979664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-19T13:31:16.990969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.361265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:16.991026Z","caller":"traceutil/trace.go:171","msg":"trace[6661536] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1048; }","duration":"701.446267ms","start":"2026-04-19T13:31:16.289565Z","end":"2026-04-19T13:31:16.991011Z","steps":["trace[6661536] 'agreement among raft nodes before linearized reading' (duration: 701.343434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:16.991028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.701235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-19T13:31:16.991057Z","caller":"traceutil/trace.go:171","msg":"trace[966679391] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1048; }","duration":"512.146898ms","start":"2026-04-19T13:31:16.478891Z","end":"2026-04-19T13:31:16.991037Z","steps":["trace[966679391] 'agreement among raft nodes before linearized reading' (duration: 511.966484ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:16.991074Z","caller":"traceutil/trace.go:171","msg":"trace[606404657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1048; }","duration":"732.798787ms","start":"2026-04-19T13:31:16.258263Z","end":"2026-04-19T13:31:16.991061Z","steps":["trace[606404657] 'agreement among raft nodes before linearized reading' (duration: 732.620943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:16.991115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:16.258244Z","time spent":"732.863168ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-19T13:31:16.991137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:16.478861Z","time spent":"512.263051ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":29,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-04-19T13:31:16.991173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:16.289555Z","time spent":"701.6031ms","remote":"127.0.0.1:33290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-04-19T13:31:16.991408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.788619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-19T13:31:16.991459Z","caller":"traceutil/trace.go:171","msg":"trace[2117508806] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1048; }","duration":"723.85291ms","start":"2026-04-19T13:31:16.267587Z","end":"2026-04-19T13:31:16.99144Z","steps":["trace[2117508806] 'agreement among raft nodes before linearized reading' (duration: 723.783789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:16.991402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.041392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-19T13:31:16.991606Z","caller":"traceutil/trace.go:171","msg":"trace[1151040368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1048; }","duration":"733.289248ms","start":"2026-04-19T13:31:16.258291Z","end":"2026-04-19T13:31:16.99158Z","steps":["trace[1151040368] 'agreement among raft nodes before linearized reading' (duration: 732.600772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:16.991869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:16.258279Z","time spent":"733.567274ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-19T13:31:16.991543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:16.267575Z","time spent":"723.959623ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-19T13:31:16.992244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.933362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:31:16.992294Z","caller":"traceutil/trace.go:171","msg":"trace[398382575] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1048; }","duration":"734.010533ms","start":"2026-04-19T13:31:16.258269Z","end":"2026-04-19T13:31:16.992279Z","steps":["trace[398382575] 'agreement among raft nodes before linearized reading' (duration: 732.280554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:16.992328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:16.258253Z","time spent":"734.067415ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-19T13:31:16.991283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:16.121395Z","time spent":"869.459157ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:31:17.161679Z","caller":"traceutil/trace.go:171","msg":"trace[1426552519] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"165.533264ms","start":"2026-04-19T13:31:16.996123Z","end":"2026-04-19T13:31:17.161656Z","steps":["trace[1426552519] 'process raft request' (duration: 107.544905ms)","trace[1426552519] 'compare' (duration: 57.697013ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:17.245541Z","caller":"traceutil/trace.go:171","msg":"trace[675932723] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"248.718841ms","start":"2026-04-19T13:31:16.996797Z","end":"2026-04-19T13:31:17.245516Z","steps":["trace[675932723] 'process raft request' (duration: 248.67165ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:17.245741Z","caller":"traceutil/trace.go:171","msg":"trace[1190350293] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"249.386096ms","start":"2026-04-19T13:31:16.99634Z","end":"2026-04-19T13:31:17.245726Z","steps":["trace[1190350293] 'process raft request' (duration: 248.999827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:17.416299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.684167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:17.416378Z","caller":"traceutil/trace.go:171","msg":"trace[1349174130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1051; }","duration":"103.816269ms","start":"2026-04-19T13:31:17.312544Z","end":"2026-04-19T13:31:17.416361Z","steps":["trace[1349174130] 'range keys from in-memory index tree' (duration: 103.576575ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:29.45026Z","caller":"traceutil/trace.go:171","msg":"trace[941162093] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"394.188896ms","start":"2026-04-19T13:31:29.056051Z","end":"2026-04-19T13:31:29.45024Z","steps":["trace[941162093] 'process raft request' (duration: 394.054541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:29.450386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:29.056041Z","time spent":"394.281877ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:31:30.361079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.255153ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:31:30.361273Z","caller":"traceutil/trace.go:171","msg":"trace[354059997] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"196.332606ms","start":"2026-04-19T13:31:30.164922Z","end":"2026-04-19T13:31:30.361255Z","steps":["trace[354059997] 'process raft request' (duration: 196.279255ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:30.361349Z","caller":"traceutil/trace.go:171","msg":"trace[1014513585] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"1.239594273s","start":"2026-04-19T13:31:29.121732Z","end":"2026-04-19T13:31:30.361327Z","steps":["trace[1014513585] 'process raft request' (duration: 545.011153ms)","trace[1014513585] 'compare' (duration: 693.907314ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:30.361435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:29.121716Z","time spent":"1.239674354s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:31:30.361434Z","caller":"traceutil/trace.go:171","msg":"trace[1660529939] linearizableReadLoop","detail":"{readStateIndex:1191; appliedIndex:1189; }","duration":"1.137284557s","start":"2026-04-19T13:31:29.224091Z","end":"2026-04-19T13:31:30.361375Z","steps":["trace[1660529939] 'read index received' (duration: 226.04364ms)","trace[1660529939] 'applied index is now lower than readState.Index' (duration: 911.234557ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:30.36164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137551964s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-19T13:31:30.361676Z","caller":"traceutil/trace.go:171","msg":"trace[191451693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1142; }","duration":"1.137639045s","start":"2026-04-19T13:31:29.224024Z","end":"2026-04-19T13:31:30.361663Z","steps":["trace[191451693] 'agreement among raft nodes before linearized reading' (duration: 1.137517093s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:30.361704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:29.224003Z","time spent":"1.137694706s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-19T13:31:30.361718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044593123s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:30.361769Z","caller":"traceutil/trace.go:171","msg":"trace[1009617773] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1142; }","duration":"1.044700685s","start":"2026-04-19T13:31:29.317049Z","end":"2026-04-19T13:31:30.361749Z","steps":["trace[1009617773] 'agreement among raft nodes before linearized reading' (duration: 1.044554932s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:30.361771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.440968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:31:30.361822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:29.317033Z","time spent":"1.044779437s","remote":"127.0.0.1:45676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-19T13:31:30.361833Z","caller":"traceutil/trace.go:171","msg":"trace[725583042] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1142; }","duration":"643.53495ms","start":"2026-04-19T13:31:29.718284Z","end":"2026-04-19T13:31:30.361819Z","steps":["trace[725583042] 'agreement among raft nodes before linearized reading' (duration: 643.440728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:30.361872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:29.718269Z","time spent":"643.594092ms","remote":"127.0.0.1:46078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-19T13:31:30.362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044649194s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-19T13:31:30.362031Z","caller":"traceutil/trace.go:171","msg":"trace[1139493330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1142; }","duration":"1.044748146s","start":"2026-04-19T13:31:29.317274Z","end":"2026-04-19T13:31:30.362022Z","steps":["trace[1139493330] 'agreement among raft nodes before linearized reading' (duration: 1.044664604s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:30.362061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:29.317262Z","time spent":"1.044790597s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-19T13:31:30.362081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.731455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-19T13:31:30.362111Z","caller":"traceutil/trace.go:171","msg":"trace[241322895] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1142; }","duration":"202.797825ms","start":"2026-04-19T13:31:30.159305Z","end":"2026-04-19T13:31:30.362103Z","steps":["trace[241322895] 'agreement among raft nodes before linearized reading' (duration: 202.710383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:30.362351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.045052343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:31:30.362406Z","caller":"traceutil/trace.go:171","msg":"trace[1504477066] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1142; }","duration":"1.045114124s","start":"2026-04-19T13:31:29.317279Z","end":"2026-04-19T13:31:30.362393Z","steps":["trace[1504477066] 'agreement among raft nodes before linearized reading' (duration: 1.04492628s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:30.362437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:29.317273Z","time spent":"1.045156525s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-19T13:31:38.512783Z","caller":"traceutil/trace.go:171","msg":"trace[716543666] linearizableReadLoop","detail":"{readStateIndex:1220; appliedIndex:1219; }","duration":"102.923463ms","start":"2026-04-19T13:31:38.409836Z","end":"2026-04-19T13:31:38.512759Z","steps":["trace[716543666] 'read index received' (duration: 102.683067ms)","trace[716543666] 'applied index is now lower than readState.Index' (duration: 239.126µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:38.51291Z","caller":"traceutil/trace.go:171","msg":"trace[535231256] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"126.295284ms","start":"2026-04-19T13:31:38.386543Z","end":"2026-04-19T13:31:38.512838Z","steps":["trace[535231256] 'process raft request' (duration: 126.065319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:38.512978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.133829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:31:38.513016Z","caller":"traceutil/trace.go:171","msg":"trace[1241432613] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1168; }","duration":"103.21725ms","start":"2026-04-19T13:31:38.409789Z","end":"2026-04-19T13:31:38.513006Z","steps":["trace[1241432613] 'agreement among raft nodes before linearized reading' (duration: 103.088727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:38.513036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.155619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-19T13:31:38.513073Z","caller":"traceutil/trace.go:171","msg":"trace[790750797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1168; }","duration":"103.23066ms","start":"2026-04-19T13:31:38.409835Z","end":"2026-04-19T13:31:38.513066Z","steps":["trace[790750797] 'agreement among raft nodes before linearized reading' (duration: 103.158328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:38.513144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.906387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-19T13:31:38.513159Z","caller":"traceutil/trace.go:171","msg":"trace[1784146660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1168; }","duration":"100.931727ms","start":"2026-04-19T13:31:38.412224Z","end":"2026-04-19T13:31:38.513155Z","steps":["trace[1784146660] 'agreement among raft nodes before linearized reading' (duration: 100.892386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:38.513252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.329666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-19T13:31:38.51331Z","caller":"traceutil/trace.go:171","msg":"trace[495430007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1168; }","duration":"101.410797ms","start":"2026-04-19T13:31:38.411889Z","end":"2026-04-19T13:31:38.5133Z","steps":["trace[495430007] 'agreement among raft nodes before linearized reading' (duration: 101.229703ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:42.640027Z","caller":"traceutil/trace.go:171","msg":"trace[1582341304] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"112.952355ms","start":"2026-04-19T13:31:42.527056Z","end":"2026-04-19T13:31:42.640008Z","steps":["trace[1582341304] 'process raft request' (duration: 112.705579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:47.160554Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704524392,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-19T13:31:47.177909Z","caller":"traceutil/trace.go:171","msg":"trace[1955843887] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"517.869513ms","start":"2026-04-19T13:31:46.660009Z","end":"2026-04-19T13:31:47.177879Z","steps":["trace[1955843887] 'read index received' (duration: 517.603497ms)","trace[1955843887] 'applied index is now lower than readState.Index' (duration: 264.646µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:47.177968Z","caller":"traceutil/trace.go:171","msg":"trace[402952457] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"525.721075ms","start":"2026-04-19T13:31:46.652212Z","end":"2026-04-19T13:31:47.177933Z","steps":["trace[402952457] 'process raft request' (duration: 525.478759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:47.178156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.137049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:31:47.178206Z","caller":"traceutil/trace.go:171","msg":"trace[556961268] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1214; }","duration":"518.236261ms","start":"2026-04-19T13:31:46.659961Z","end":"2026-04-19T13:31:47.178197Z","steps":["trace[556961268] 'agreement among raft nodes before linearized reading' (duration: 518.070927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:47.178247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:46.659941Z","time spent":"518.296742ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-19T13:31:47.178292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:46.652189Z","time spent":"525.97054ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:31:47.178385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.359511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-19T13:31:47.178242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.414069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-19T13:31:47.178427Z","caller":"traceutil/trace.go:171","msg":"trace[793125594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1214; }","duration":"514.411023ms","start":"2026-04-19T13:31:46.664004Z","end":"2026-04-19T13:31:47.178415Z","steps":["trace[793125594] 'agreement among raft nodes before linearized reading' (duration: 514.335171ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:47.178439Z","caller":"traceutil/trace.go:171","msg":"trace[1897436958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1214; }","duration":"516.636273ms","start":"2026-04-19T13:31:46.661794Z","end":"2026-04-19T13:31:47.178431Z","steps":["trace[1897436958] 'agreement among raft nodes before linearized reading' (duration: 516.365287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:47.178462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:46.663998Z","time spent":"514.458524ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-19T13:31:47.17847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:46.661784Z","time spent":"516.677475ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-19T13:31:47.17832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.231203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-19T13:31:47.178551Z","caller":"traceutil/trace.go:171","msg":"trace[423416000] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1214; }","duration":"449.494389ms","start":"2026-04-19T13:31:46.729049Z","end":"2026-04-19T13:31:47.178544Z","steps":["trace[423416000] 'agreement among raft nodes before linearized reading' (duration: 449.217593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:47.178583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:46.729035Z","time spent":"449.54177ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-19T13:31:47.931415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.648768ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:31:47.931512Z","caller":"traceutil/trace.go:171","msg":"trace[2101227395] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"749.032466ms","start":"2026-04-19T13:31:47.182462Z","end":"2026-04-19T13:31:47.931495Z","steps":["trace[2101227395] 'process raft request' (duration: 449.237674ms)","trace[2101227395] 'compare' (duration: 299.427833ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:47.931569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:47.182441Z","time spent":"749.100827ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:31:48.534997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.297153ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:31:48.535221Z","caller":"traceutil/trace.go:171","msg":"trace[354743586] linearizableReadLoop","detail":"{readStateIndex:1271; appliedIndex:1267; }","duration":"1.220271697s","start":"2026-04-19T13:31:47.31493Z","end":"2026-04-19T13:31:48.535201Z","steps":["trace[354743586] 'read index received' (duration: 316.780326ms)","trace[354743586] 'applied index is now lower than readState.Index' (duration: 903.490401ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:48.535358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220420091s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:48.535393Z","caller":"traceutil/trace.go:171","msg":"trace[1690268186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1218; }","duration":"1.220483222s","start":"2026-04-19T13:31:47.3149Z","end":"2026-04-19T13:31:48.535383Z","steps":["trace[1690268186] 'agreement among raft nodes before linearized reading' (duration: 1.22042486s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:48.535434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:47.314886Z","time spent":"1.220538073s","remote":"127.0.0.1:45676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-19T13:31:48.535433Z","caller":"traceutil/trace.go:171","msg":"trace[1220291337] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"1.351540167s","start":"2026-04-19T13:31:47.183881Z","end":"2026-04-19T13:31:48.535421Z","steps":["trace[1220291337] 'process raft request' (duration: 1.35122159s)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:48.535468Z","caller":"traceutil/trace.go:171","msg":"trace[1037262808] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"1.352897259s","start":"2026-04-19T13:31:47.182538Z","end":"2026-04-19T13:31:48.535435Z","steps":["trace[1037262808] 'process raft request' (duration: 1.154071105s)","trace[1037262808] 'compare' (duration: 198.187979ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:48.535583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:47.183874Z","time spent":"1.351611879s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:31:48.535618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.980463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-19T13:31:48.535636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:47.182527Z","time spent":"1.353017251s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:31:48.535669Z","caller":"traceutil/trace.go:171","msg":"trace[616644656] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1218; }","duration":"974.039835ms","start":"2026-04-19T13:31:47.561617Z","end":"2026-04-19T13:31:48.535657Z","steps":["trace[616644656] 'agreement among raft nodes before linearized reading' (duration: 973.904132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:48.535698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:47.561559Z","time spent":"974.133698ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-19T13:31:48.535359Z","caller":"traceutil/trace.go:171","msg":"trace[650465923] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"1.351382763s","start":"2026-04-19T13:31:47.18394Z","end":"2026-04-19T13:31:48.535322Z","steps":["trace[650465923] 'process raft request' (duration: 1.35122613s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:48.535799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:47.183926Z","time spent":"1.351827154s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:31:48.535874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.955401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.156\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-19T13:31:48.535911Z","caller":"traceutil/trace.go:171","msg":"trace[951877544] range","detail":"{range_begin:/registry/masterleases/199.19.213.156; range_end:; response_count:1; response_revision:1218; }","duration":"422.026462ms","start":"2026-04-19T13:31:48.113871Z","end":"2026-04-19T13:31:48.535898Z","steps":["trace[951877544] 'agreement among raft nodes before linearized reading' (duration: 421.894199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:48.535942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:48.113852Z","time spent":"422.083324ms","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.156\" "} {"level":"warn","ts":"2026-04-19T13:31:49.537773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.356828ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-04-19T13:31:49.537834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:48.536704Z","time spent":"1.001127172s","remote":"127.0.0.1:45692","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-19T13:31:49.634643Z","caller":"traceutil/trace.go:171","msg":"trace[261456671] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1271; }","duration":"1.091543757s","start":"2026-04-19T13:31:48.543074Z","end":"2026-04-19T13:31:49.634618Z","steps":["trace[261456671] 'read index received' (duration: 107.351876ms)","trace[261456671] 'applied index is now lower than readState.Index' (duration: 984.190971ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:49.634759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.09166692s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:49.634791Z","caller":"traceutil/trace.go:171","msg":"trace[1776407972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1219; }","duration":"1.091731551s","start":"2026-04-19T13:31:48.543048Z","end":"2026-04-19T13:31:49.63478Z","steps":["trace[1776407972] 'agreement among raft nodes before linearized reading' (duration: 1.091660999s)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:49.63478Z","caller":"traceutil/trace.go:171","msg":"trace[1953460636] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"1.095768925s","start":"2026-04-19T13:31:48.53896Z","end":"2026-04-19T13:31:49.634729Z","steps":["trace[1953460636] 'process raft request' (duration: 1.095461568s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:49.634831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:48.54304Z","time spent":"1.091783423s","remote":"127.0.0.1:45676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-19T13:31:49.635043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:48.538944Z","time spent":"1.095954018s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:31:50.615795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.739023ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:31:50.616023Z","caller":"traceutil/trace.go:171","msg":"trace[1712335807] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"1.431291364s","start":"2026-04-19T13:31:49.184707Z","end":"2026-04-19T13:31:50.615998Z","steps":["trace[1712335807] 'process raft request' (duration: 725.275475ms)","trace[1712335807] 'compare' (duration: 705.60518ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:50.616128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:49.184679Z","time spent":"1.431401197s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:31:50.616312Z","caller":"traceutil/trace.go:171","msg":"trace[1029304948] linearizableReadLoop","detail":"{readStateIndex:1275; appliedIndex:1273; }","duration":"980.349592ms","start":"2026-04-19T13:31:49.635934Z","end":"2026-04-19T13:31:50.616284Z","steps":["trace[1029304948] 'read index received' (duration: 273.944674ms)","trace[1029304948] 'applied index is now lower than readState.Index' (duration: 706.403108ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:50.61635Z","caller":"traceutil/trace.go:171","msg":"trace[854753291] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"1.077608695s","start":"2026-04-19T13:31:49.538715Z","end":"2026-04-19T13:31:50.616323Z","steps":["trace[854753291] 'process raft request' (duration: 1.077192995s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:50.616486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.542876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:31:50.616489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:49.538699Z","time spent":"1.077710386s","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:31:50.616526Z","caller":"traceutil/trace.go:171","msg":"trace[1284984642] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1221; }","duration":"980.623948ms","start":"2026-04-19T13:31:49.635894Z","end":"2026-04-19T13:31:50.616518Z","steps":["trace[1284984642] 'agreement among raft nodes before linearized reading' (duration: 980.514785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:50.61655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:49.635876Z","time spent":"980.668499ms","remote":"127.0.0.1:45666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-19T13:31:50.778123Z","caller":"traceutil/trace.go:171","msg":"trace[564082087] linearizableReadLoop","detail":"{readStateIndex:1276; appliedIndex:1275; }","duration":"161.699785ms","start":"2026-04-19T13:31:50.616386Z","end":"2026-04-19T13:31:50.778086Z","steps":["trace[564082087] 'read index received' (duration: 152.86402ms)","trace[564082087] 'applied index is now lower than readState.Index' (duration: 8.834495ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:50.778137Z","caller":"traceutil/trace.go:171","msg":"trace[80767265] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"564.098892ms","start":"2026-04-19T13:31:50.213998Z","end":"2026-04-19T13:31:50.778097Z","steps":["trace[80767265] 'process raft request' (duration: 555.239377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:50.77826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.685717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-19T13:31:50.778314Z","caller":"traceutil/trace.go:171","msg":"trace[1246885492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1222; }","duration":"238.747549ms","start":"2026-04-19T13:31:50.539553Z","end":"2026-04-19T13:31:50.778301Z","steps":["trace[1246885492] 'agreement among raft nodes before linearized reading' (duration: 238.555564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:50.778362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:50.213981Z","time spent":"564.310708ms","remote":"127.0.0.1:45734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T13:31:50.778383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.043013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-19T13:31:50.778317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.853561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-19T13:31:50.778526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.506441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:50.778548Z","caller":"traceutil/trace.go:171","msg":"trace[1657990425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1222; }","duration":"155.542701ms","start":"2026-04-19T13:31:50.622997Z","end":"2026-04-19T13:31:50.778539Z","steps":["trace[1657990425] 'agreement among raft nodes before linearized reading' (duration: 155.514371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:50.778524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.342177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-04-19T13:31:50.778515Z","caller":"traceutil/trace.go:171","msg":"trace[124095083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1222; }","duration":"239.090316ms","start":"2026-04-19T13:31:50.539405Z","end":"2026-04-19T13:31:50.778496Z","steps":["trace[124095083] 'agreement among raft nodes before linearized reading' (duration: 238.735788ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:50.778578Z","caller":"traceutil/trace.go:171","msg":"trace[1654387344] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1222; }","duration":"158.429399ms","start":"2026-04-19T13:31:50.620137Z","end":"2026-04-19T13:31:50.778567Z","steps":["trace[1654387344] 'agreement among raft nodes before linearized reading' (duration: 158.161923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:50.778745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.598212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:31:50.778766Z","caller":"traceutil/trace.go:171","msg":"trace[1668265916] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1222; }","duration":"842.648663ms","start":"2026-04-19T13:31:49.936112Z","end":"2026-04-19T13:31:50.77876Z","steps":["trace[1668265916] 'agreement among raft nodes before linearized reading' (duration: 842.098131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:50.778783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:49.936096Z","time spent":"842.681125ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-19T13:31:50.778465Z","caller":"traceutil/trace.go:171","msg":"trace[1237039943] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1222; }","duration":"238.150335ms","start":"2026-04-19T13:31:50.540296Z","end":"2026-04-19T13:31:50.778446Z","steps":["trace[1237039943] 'agreement among raft nodes before linearized reading' (duration: 237.891869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:51.82283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.903651ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:51.822936Z","caller":"traceutil/trace.go:171","msg":"trace[112013546] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1227; }","duration":"264.019104ms","start":"2026-04-19T13:31:51.558901Z","end":"2026-04-19T13:31:51.82292Z","steps":["trace[112013546] 'range keys from in-memory index tree' (duration: 263.890081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:51.823039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.812747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-19T13:31:51.823095Z","caller":"traceutil/trace.go:171","msg":"trace[1774265022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1227; }","duration":"183.905109ms","start":"2026-04-19T13:31:51.63917Z","end":"2026-04-19T13:31:51.823076Z","steps":["trace[1774265022] 'range keys from in-memory index tree' (duration: 183.613072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:52.816386Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704524421,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T13:31:52.963998Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.129023685s","expected-duration":"1s"} {"level":"info","ts":"2026-04-19T13:31:52.964453Z","caller":"traceutil/trace.go:171","msg":"trace[646146348] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"1.137708215s","start":"2026-04-19T13:31:51.826721Z","end":"2026-04-19T13:31:52.964429Z","steps":["trace[646146348] 'process raft request' (duration: 1.137558502s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:52.96459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:51.8267Z","time spent":"1.137817558s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:31:53.064069Z","caller":"traceutil/trace.go:171","msg":"trace[1567467722] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"442.20246ms","start":"2026-04-19T13:31:52.621846Z","end":"2026-04-19T13:31:53.064049Z","steps":["trace[1567467722] 'process raft request' (duration: 432.447874ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:53.064072Z","caller":"traceutil/trace.go:171","msg":"trace[692378923] linearizableReadLoop","detail":"{readStateIndex:1284; appliedIndex:1281; }","duration":"748.066193ms","start":"2026-04-19T13:31:52.315978Z","end":"2026-04-19T13:31:53.064044Z","steps":["trace[692378923] 'read index received' (duration: 648.312313ms)","trace[692378923] 'applied index is now lower than readState.Index' (duration: 99.75258ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:53.06419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:52.621822Z","time spent":"442.301672ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:31:53.064287Z","caller":"traceutil/trace.go:171","msg":"trace[919969320] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"320.380499ms","start":"2026-04-19T13:31:52.743901Z","end":"2026-04-19T13:31:53.064282Z","steps":["trace[919969320] 'process raft request' (duration: 320.077562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:53.064315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:52.743872Z","time spent":"320.42968ms","remote":"127.0.0.1:45808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5964,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:31:53.066864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.870878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:53.066944Z","caller":"traceutil/trace.go:171","msg":"trace[311614246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1230; }","duration":"750.992271ms","start":"2026-04-19T13:31:52.31593Z","end":"2026-04-19T13:31:53.066922Z","steps":["trace[311614246] 'agreement among raft nodes before linearized reading' (duration: 748.442512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:53.066997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:52.315909Z","time spent":"751.073913ms","remote":"127.0.0.1:45676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-19T13:31:53.14186Z","caller":"traceutil/trace.go:171","msg":"trace[768726278] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"168.384839ms","start":"2026-04-19T13:31:52.973454Z","end":"2026-04-19T13:31:53.141839Z","steps":["trace[768726278] 'process raft request' (duration: 168.218315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:53.142012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.873363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-19T13:31:53.14208Z","caller":"traceutil/trace.go:171","msg":"trace[138085311] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1231; }","duration":"289.977425ms","start":"2026-04-19T13:31:52.852085Z","end":"2026-04-19T13:31:53.142063Z","steps":["trace[138085311] 'agreement among raft nodes before linearized reading' (duration: 289.73567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:53.142228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.562763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-19T13:31:53.14234Z","caller":"traceutil/trace.go:171","msg":"trace[2015599036] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1231; }","duration":"570.730437ms","start":"2026-04-19T13:31:52.571589Z","end":"2026-04-19T13:31:53.14232Z","steps":["trace[2015599036] 'agreement among raft nodes before linearized reading' (duration: 570.503722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:53.142413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:52.571572Z","time spent":"570.827229ms","remote":"127.0.0.1:33788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-19T13:31:53.14259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.476417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:31:53.142658Z","caller":"traceutil/trace.go:171","msg":"trace[760725692] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1231; }","duration":"290.575559ms","start":"2026-04-19T13:31:52.852063Z","end":"2026-04-19T13:31:53.142638Z","steps":["trace[760725692] 'agreement among raft nodes before linearized reading' (duration: 289.775181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:53.142855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.370418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-19T13:31:53.142913Z","caller":"traceutil/trace.go:171","msg":"trace[1144011048] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1231; }","duration":"310.459329ms","start":"2026-04-19T13:31:52.83244Z","end":"2026-04-19T13:31:53.142899Z","steps":["trace[1144011048] 'agreement among raft nodes before linearized reading' (duration: 310.273945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:53.142956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:52.832424Z","time spent":"310.519221ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-19T13:31:53.143221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.124481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-19T13:31:53.143314Z","caller":"traceutil/trace.go:171","msg":"trace[1102775883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1231; }","duration":"291.243925ms","start":"2026-04-19T13:31:52.852057Z","end":"2026-04-19T13:31:53.143301Z","steps":["trace[1102775883] 'agreement among raft nodes before linearized reading' (duration: 291.075781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:53.292886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.269971ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:31:53.292981Z","caller":"traceutil/trace.go:171","msg":"trace[963220398] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"147.157808ms","start":"2026-04-19T13:31:53.145808Z","end":"2026-04-19T13:31:53.292966Z","steps":["trace[963220398] 'process raft request' (duration: 37.727174ms)","trace[963220398] 'compare' (duration: 109.137537ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:31:53.347768Z","caller":"traceutil/trace.go:171","msg":"trace[361743970] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"199.996531ms","start":"2026-04-19T13:31:53.14775Z","end":"2026-04-19T13:31:53.347746Z","steps":["trace[361743970] 'process raft request' (duration: 199.927239ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:53.348041Z","caller":"traceutil/trace.go:171","msg":"trace[1075120400] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"200.41727ms","start":"2026-04-19T13:31:53.147606Z","end":"2026-04-19T13:31:53.348023Z","steps":["trace[1075120400] 'process raft request' (duration: 200.040771ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:53.348152Z","caller":"traceutil/trace.go:171","msg":"trace[1840948496] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"200.83255ms","start":"2026-04-19T13:31:53.147312Z","end":"2026-04-19T13:31:53.348145Z","steps":["trace[1840948496] 'process raft request' (duration: 200.211216ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:53.348208Z","caller":"traceutil/trace.go:171","msg":"trace[258596437] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"200.41809ms","start":"2026-04-19T13:31:53.147784Z","end":"2026-04-19T13:31:53.348202Z","steps":["trace[258596437] 'process raft request' (duration: 199.928499ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:53.348204Z","caller":"traceutil/trace.go:171","msg":"trace[1643177189] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"200.289188ms","start":"2026-04-19T13:31:53.147902Z","end":"2026-04-19T13:31:53.348191Z","steps":["trace[1643177189] 'process raft request' (duration: 200.061013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:53.745412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.969008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:31:53.745521Z","caller":"traceutil/trace.go:171","msg":"trace[1604771557] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"391.405743ms","start":"2026-04-19T13:31:53.354095Z","end":"2026-04-19T13:31:53.745501Z","steps":["trace[1604771557] 'process raft request' (duration: 84.286292ms)","trace[1604771557] 'compare' (duration: 306.462776ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:53.745577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:53.354069Z","time spent":"391.487376ms","remote":"127.0.0.1:45734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T13:31:53.758133Z","caller":"traceutil/trace.go:171","msg":"trace[681690211] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"363.624691ms","start":"2026-04-19T13:31:53.394488Z","end":"2026-04-19T13:31:53.758112Z","steps":["trace[681690211] 'process raft request' (duration: 363.497738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:53.758249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:53.394463Z","time spent":"363.728803ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:31:54.508108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.73812ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-19T13:31:54.508212Z","caller":"traceutil/trace.go:171","msg":"trace[1060394019] linearizableReadLoop","detail":"{readStateIndex:1295; appliedIndex:1294; }","duration":"570.244595ms","start":"2026-04-19T13:31:53.937954Z","end":"2026-04-19T13:31:54.508199Z","steps":["trace[1060394019] 'read index received' (duration: 213.458603ms)","trace[1060394019] 'applied index is now lower than readState.Index' (duration: 356.784942ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:54.508304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.339647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-19T13:31:54.508326Z","caller":"traceutil/trace.go:171","msg":"trace[1623742477] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1240; }","duration":"570.401108ms","start":"2026-04-19T13:31:53.937915Z","end":"2026-04-19T13:31:54.508316Z","steps":["trace[1623742477] 'agreement among raft nodes before linearized reading' (duration: 570.349476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:54.50835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:31:53.937898Z","time spent":"570.446199ms","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-04-19T13:31:54.508458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.035756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:31:54.508549Z","caller":"traceutil/trace.go:171","msg":"trace[364034825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1240; }","duration":"195.149899ms","start":"2026-04-19T13:31:54.313374Z","end":"2026-04-19T13:31:54.508524Z","steps":["trace[364034825] 'agreement among raft nodes before linearized reading' (duration: 195.018415ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:55.170754Z","caller":"traceutil/trace.go:171","msg":"trace[1064789095] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"198.111897ms","start":"2026-04-19T13:31:54.972618Z","end":"2026-04-19T13:31:55.17073Z","steps":["trace[1064789095] 'process raft request' (duration: 197.833301ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:55.272842Z","caller":"traceutil/trace.go:171","msg":"trace[683244129] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"202.768285ms","start":"2026-04-19T13:31:55.070051Z","end":"2026-04-19T13:31:55.272819Z","steps":["trace[683244129] 'process raft request' (duration: 202.723324ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:55.272869Z","caller":"traceutil/trace.go:171","msg":"trace[541115341] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"284.747974ms","start":"2026-04-19T13:31:54.988091Z","end":"2026-04-19T13:31:55.272839Z","steps":["trace[541115341] 'process raft request' (duration: 284.522138ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:01.438015Z","caller":"traceutil/trace.go:171","msg":"trace[2123960522] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1350; }","duration":"300.928178ms","start":"2026-04-19T13:32:01.137068Z","end":"2026-04-19T13:32:01.437996Z","steps":["trace[2123960522] 'read index received' (duration: 300.900897ms)","trace[2123960522] 'applied index is now lower than readState.Index' (duration: 26.401µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:32:01.43811Z","caller":"traceutil/trace.go:171","msg":"trace[2024992726] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"404.334143ms","start":"2026-04-19T13:32:01.033769Z","end":"2026-04-19T13:32:01.438103Z","steps":["trace[2024992726] 'process raft request' (duration: 404.045487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:01.438198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.033743Z","time spent":"404.388394ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:32:01.438254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.165453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-19T13:32:01.4385Z","caller":"traceutil/trace.go:171","msg":"trace[209603903] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1295; }","duration":"301.270466ms","start":"2026-04-19T13:32:01.137032Z","end":"2026-04-19T13:32:01.438303Z","steps":["trace[209603903] 'agreement among raft nodes before linearized reading' (duration: 301.087742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:01.438546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.137019Z","time spent":"301.519031ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-19T13:32:01.938418Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5164394733704524548,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T13:32:02.40733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.181851ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:32:02.407471Z","caller":"traceutil/trace.go:171","msg":"trace[661308396] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1295; }","duration":"848.327304ms","start":"2026-04-19T13:32:01.559119Z","end":"2026-04-19T13:32:02.407446Z","steps":["trace[661308396] 'range keys from in-memory index tree' (duration: 848.165401ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:02.40786Z","caller":"traceutil/trace.go:171","msg":"trace[880418413] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"1.117131408s","start":"2026-04-19T13:32:01.290665Z","end":"2026-04-19T13:32:02.407797Z","steps":["trace[880418413] 'process raft request' (duration: 1.108907178s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.408488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.290647Z","time spent":"1.117337474s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:32:02.40883Z","caller":"traceutil/trace.go:171","msg":"trace[781732085] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1351; }","duration":"970.742009ms","start":"2026-04-19T13:32:01.438072Z","end":"2026-04-19T13:32:02.408814Z","steps":["trace[781732085] 'read index received' (duration: 961.514745ms)","trace[781732085] 'applied index is now lower than readState.Index' (duration: 9.225884ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:32:02.409003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065931775s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-04-19T13:32:02.409022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084875393s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-19T13:32:02.409056Z","caller":"traceutil/trace.go:171","msg":"trace[482657621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1297; }","duration":"1.084913154s","start":"2026-04-19T13:32:01.324132Z","end":"2026-04-19T13:32:02.409045Z","steps":["trace[482657621] 'agreement among raft nodes before linearized reading' (duration: 1.084780671s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.409092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.324093Z","time spent":"1.084992716s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-19T13:32:02.409095Z","caller":"traceutil/trace.go:171","msg":"trace[250995550] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"966.605454ms","start":"2026-04-19T13:32:01.442479Z","end":"2026-04-19T13:32:02.409085Z","steps":["trace[250995550] 'process raft request' (duration: 966.243575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.409188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093134363s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:32:02.409186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.442463Z","time spent":"966.662185ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:32:02.409237Z","caller":"traceutil/trace.go:171","msg":"trace[1156922675] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1297; }","duration":"1.093165254s","start":"2026-04-19T13:32:01.316047Z","end":"2026-04-19T13:32:02.409212Z","steps":["trace[1156922675] 'agreement among raft nodes before linearized reading' (duration: 1.093121303s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.409269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033317819s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:32:02.409305Z","caller":"traceutil/trace.go:171","msg":"trace[1910105035] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1297; }","duration":"1.033384119s","start":"2026-04-19T13:32:01.375911Z","end":"2026-04-19T13:32:02.409295Z","steps":["trace[1910105035] 'agreement among raft nodes before linearized reading' (duration: 1.033283427s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.409335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.375896Z","time spent":"1.033434011s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-19T13:32:02.409342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.027101384s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-19T13:32:02.409302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.315979Z","time spent":"1.093309007s","remote":"127.0.0.1:45676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-19T13:32:02.409369Z","caller":"traceutil/trace.go:171","msg":"trace[1261278875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1297; }","duration":"1.027149806s","start":"2026-04-19T13:32:01.382211Z","end":"2026-04-19T13:32:02.409361Z","steps":["trace[1261278875] 'agreement among raft nodes before linearized reading' (duration: 1.027073714s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.409441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.382194Z","time spent":"1.027238928s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-19T13:32:02.409373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.204627086s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:32:02.409544Z","caller":"traceutil/trace.go:171","msg":"trace[1863610156] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1297; }","duration":"1.204758109s","start":"2026-04-19T13:32:01.204716Z","end":"2026-04-19T13:32:02.409474Z","steps":["trace[1863610156] 'agreement among raft nodes before linearized reading' (duration: 1.204607835s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.409555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.635855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T13:32:02.409585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.204682Z","time spent":"1.204892852s","remote":"127.0.0.1:46144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-04-19T13:32:02.40959Z","caller":"traceutil/trace.go:171","msg":"trace[1588646899] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1297; }","duration":"241.706187ms","start":"2026-04-19T13:32:02.167874Z","end":"2026-04-19T13:32:02.40958Z","steps":["trace[1588646899] 'agreement among raft nodes before linearized reading' (duration: 241.646856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.409526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028944666s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-19T13:32:02.409645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.218675121s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-19T13:32:02.409677Z","caller":"traceutil/trace.go:171","msg":"trace[178539444] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1297; }","duration":"1.218741603s","start":"2026-04-19T13:32:01.190926Z","end":"2026-04-19T13:32:02.409668Z","steps":["trace[178539444] 'agreement among raft nodes before linearized reading' (duration: 1.218675241s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.4097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.190909Z","time spent":"1.218786574s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-19T13:32:02.409663Z","caller":"traceutil/trace.go:171","msg":"trace[89296509] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1297; }","duration":"1.029104971s","start":"2026-04-19T13:32:01.380544Z","end":"2026-04-19T13:32:02.409649Z","steps":["trace[89296509] 'agreement among raft nodes before linearized reading' (duration: 1.028612859s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.40979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.380535Z","time spent":"1.029239943s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-19T13:32:02.409056Z","caller":"traceutil/trace.go:171","msg":"trace[165558187] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1297; }","duration":"1.066007576s","start":"2026-04-19T13:32:01.343034Z","end":"2026-04-19T13:32:02.409042Z","steps":["trace[165558187] 'agreement among raft nodes before linearized reading' (duration: 1.065869053s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:02.409865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:01.343022Z","time spent":"1.066836355s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-19T13:32:08.689812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.10308ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:32:08.689952Z","caller":"traceutil/trace.go:171","msg":"trace[1403163074] linearizableReadLoop","detail":"{readStateIndex:1385; appliedIndex:1384; }","duration":"229.71635ms","start":"2026-04-19T13:32:08.460213Z","end":"2026-04-19T13:32:08.689929Z","steps":["trace[1403163074] 'read index received' (duration: 21.345714ms)","trace[1403163074] 'applied index is now lower than readState.Index' (duration: 208.368686ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:32:08.690019Z","caller":"traceutil/trace.go:171","msg":"trace[852143694] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"239.319902ms","start":"2026-04-19T13:32:08.450669Z","end":"2026-04-19T13:32:08.689989Z","steps":["trace[852143694] 'process raft request' (duration: 30.900385ms)","trace[852143694] 'compare' (duration: 207.822823ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:32:08.690214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.990766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-19T13:32:08.690231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.682212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:32:08.690278Z","caller":"traceutil/trace.go:171","msg":"trace[1807231716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1327; }","duration":"230.068497ms","start":"2026-04-19T13:32:08.460192Z","end":"2026-04-19T13:32:08.69026Z","steps":["trace[1807231716] 'agreement among raft nodes before linearized reading' (duration: 229.858642ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:08.690289Z","caller":"traceutil/trace.go:171","msg":"trace[1042883080] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1327; }","duration":"227.762334ms","start":"2026-04-19T13:32:08.462512Z","end":"2026-04-19T13:32:08.690274Z","steps":["trace[1042883080] 'agreement among raft nodes before linearized reading' (duration: 227.574869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:08.690277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.634531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-19T13:32:08.690214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.134651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-19T13:32:08.690352Z","caller":"traceutil/trace.go:171","msg":"trace[338083996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1327; }","duration":"224.739674ms","start":"2026-04-19T13:32:08.465594Z","end":"2026-04-19T13:32:08.690334Z","steps":["trace[338083996] 'agreement among raft nodes before linearized reading' (duration: 224.514869ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:08.690375Z","caller":"traceutil/trace.go:171","msg":"trace[1286578297] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1327; }","duration":"221.323424ms","start":"2026-04-19T13:32:08.469033Z","end":"2026-04-19T13:32:08.690357Z","steps":["trace[1286578297] 'agreement among raft nodes before linearized reading' (duration: 221.059298ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:09.003212Z","caller":"traceutil/trace.go:171","msg":"trace[1112065356] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"308.606627ms","start":"2026-04-19T13:32:08.694582Z","end":"2026-04-19T13:32:09.003188Z","steps":["trace[1112065356] 'process raft request' (duration: 308.422733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:09.003368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:08.694568Z","time spent":"308.73056ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:32:09.003532Z","caller":"traceutil/trace.go:171","msg":"trace[1199370616] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"308.875152ms","start":"2026-04-19T13:32:08.69461Z","end":"2026-04-19T13:32:09.003485Z","steps":["trace[1199370616] 'process raft request' (duration: 308.540585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:09.003708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:08.694591Z","time spent":"309.025877ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:32:09.003561Z","caller":"traceutil/trace.go:171","msg":"trace[1292990453] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1386; }","duration":"224.724874ms","start":"2026-04-19T13:32:08.778819Z","end":"2026-04-19T13:32:09.003544Z","steps":["trace[1292990453] 'read index received' (duration: 224.250154ms)","trace[1292990453] 'applied index is now lower than readState.Index' (duration: 473.47µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:32:09.003728Z","caller":"traceutil/trace.go:171","msg":"trace[680292943] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"308.229718ms","start":"2026-04-19T13:32:08.695459Z","end":"2026-04-19T13:32:09.003689Z","steps":["trace[680292943] 'process raft request' (duration: 307.924421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:09.003912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:32:08.695447Z","time spent":"308.377401ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T13:32:09.00394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.117993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-04-19T13:32:09.003996Z","caller":"traceutil/trace.go:171","msg":"trace[1750442859] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1331; }","duration":"225.208995ms","start":"2026-04-19T13:32:08.778772Z","end":"2026-04-19T13:32:09.003981Z","steps":["trace[1750442859] 'agreement among raft nodes before linearized reading' (duration: 224.823417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:37.730256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.999374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:32:37.730338Z","caller":"traceutil/trace.go:171","msg":"trace[1734405784] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1461; }","duration":"113.135647ms","start":"2026-04-19T13:32:37.617185Z","end":"2026-04-19T13:32:37.73032Z","steps":["trace[1734405784] 'count revisions from in-memory index tree' (duration: 112.891612ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:12.74322Z","caller":"traceutil/trace.go:171","msg":"trace[829966309] transaction","detail":"{read_only:false; response_revision:1618; number_of_response:1; }","duration":"122.694105ms","start":"2026-04-19T13:33:12.620496Z","end":"2026-04-19T13:33:12.74319Z","steps":["trace[829966309] 'process raft request' (duration: 122.536661ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:18.948494Z","caller":"traceutil/trace.go:171","msg":"trace[513194738] transaction","detail":"{read_only:false; response_revision:1649; number_of_response:1; }","duration":"103.736613ms","start":"2026-04-19T13:33:18.844727Z","end":"2026-04-19T13:33:18.948464Z","steps":["trace[513194738] 'process raft request' (duration: 102.741689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:33:29.973631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.767737ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:33:29.973767Z","caller":"traceutil/trace.go:171","msg":"trace[1857487242] linearizableReadLoop","detail":"{readStateIndex:1775; appliedIndex:1774; }","duration":"309.95149ms","start":"2026-04-19T13:33:29.663797Z","end":"2026-04-19T13:33:29.973748Z","steps":["trace[1857487242] 'read index received' (duration: 40.281µs)","trace[1857487242] 'applied index is now lower than readState.Index' (duration: 309.909899ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:33:29.97414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.318258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-19T13:33:29.974104Z","caller":"traceutil/trace.go:171","msg":"trace[343784561] transaction","detail":"{read_only:false; response_revision:1701; number_of_response:1; }","duration":"409.210225ms","start":"2026-04-19T13:33:29.564844Z","end":"2026-04-19T13:33:29.974054Z","steps":["trace[343784561] 'process raft request' (duration: 40.931385ms)","trace[343784561] 'compare' (duration: 367.664554ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:33:29.974187Z","caller":"traceutil/trace.go:171","msg":"trace[2032505275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1701; }","duration":"310.448481ms","start":"2026-04-19T13:33:29.663725Z","end":"2026-04-19T13:33:29.974173Z","steps":["trace[2032505275] 'agreement among raft nodes before linearized reading' (duration: 310.082962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:33:29.974229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:33:29.663705Z","time spent":"310.514933ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-19T13:33:29.974368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:33:29.564821Z","time spent":"409.375699ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:33:35.558235Z","caller":"traceutil/trace.go:171","msg":"trace[1182484893] transaction","detail":"{read_only:false; response_revision:1725; number_of_response:1; }","duration":"176.476218ms","start":"2026-04-19T13:33:35.381725Z","end":"2026-04-19T13:33:35.558201Z","steps":["trace[1182484893] 'process raft request' (duration: 171.470578ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:49.243894Z","caller":"traceutil/trace.go:171","msg":"trace[913075096] transaction","detail":"{read_only:false; response_revision:1786; number_of_response:1; }","duration":"216.983041ms","start":"2026-04-19T13:33:49.026879Z","end":"2026-04-19T13:33:49.243862Z","steps":["trace[913075096] 'process raft request' (duration: 216.808856ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:51.386826Z","caller":"traceutil/trace.go:171","msg":"trace[806197709] linearizableReadLoop","detail":"{readStateIndex:1873; appliedIndex:1872; }","duration":"125.918498ms","start":"2026-04-19T13:33:51.260881Z","end":"2026-04-19T13:33:51.3868Z","steps":["trace[806197709] 'read index received' (duration: 125.696742ms)","trace[806197709] 'applied index is now lower than readState.Index' (duration: 220.606µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:33:51.386982Z","caller":"traceutil/trace.go:171","msg":"trace[25730158] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"138.285373ms","start":"2026-04-19T13:33:51.248682Z","end":"2026-04-19T13:33:51.386967Z","steps":["trace[25730158] 'process raft request' (duration: 137.949245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:33:51.387461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.573756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-19T13:33:51.387524Z","caller":"traceutil/trace.go:171","msg":"trace[1863647198] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1795; }","duration":"126.685109ms","start":"2026-04-19T13:33:51.260824Z","end":"2026-04-19T13:33:51.387509Z","steps":["trace[1863647198] 'agreement among raft nodes before linearized reading' (duration: 126.556105ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:52.515805Z","caller":"traceutil/trace.go:171","msg":"trace[733232213] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"104.160646ms","start":"2026-04-19T13:33:52.411573Z","end":"2026-04-19T13:33:52.515733Z","steps":["trace[733232213] 'process raft request' (duration: 104.012543ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:52.516918Z","caller":"traceutil/trace.go:171","msg":"trace[954858185] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"103.756487ms","start":"2026-04-19T13:33:52.413142Z","end":"2026-04-19T13:33:52.516898Z","steps":["trace[954858185] 'process raft request' (duration: 103.536731ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:35:17.089746Z","caller":"traceutil/trace.go:171","msg":"trace[1536852870] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"103.928789ms","start":"2026-04-19T13:35:16.985781Z","end":"2026-04-19T13:35:17.08971Z","steps":["trace[1536852870] 'process raft request' (duration: 103.689043ms)"],"step_count":1}