{"level":"warn","ts":"2026-08-14T09:06:09.134058Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T09:06:09.134145Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.44: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.204.45.44:2380","--initial-cluster=instance=https://199.204.45.44:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.44:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.44: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-08-14T09:06:09.134204Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T09:06:09.134215Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.44:2380"]} {"level":"info","ts":"2026-08-14T09:06:09.134262Z","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-08-14T09:06:09.134953Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"]} {"level":"info","ts":"2026-08-14T09:06:09.135057Z","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.204.45.44:2380"],"listen-peer-urls":["https://199.204.45.44:2380"],"advertise-client-urls":["https://199.204.45.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.44: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-08-14T09:06:09.137695Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.343317ms"} {"level":"info","ts":"2026-08-14T09:06:09.142487Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a0a01fc7fbf6be45","cluster-id":"92fa3fee501eaaec"} {"level":"info","ts":"2026-08-14T09:06:09.142562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=()"} {"level":"info","ts":"2026-08-14T09:06:09.14258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became follower at term 0"} {"level":"info","ts":"2026-08-14T09:06:09.14259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a0a01fc7fbf6be45 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-14T09:06:09.142607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became follower at term 1"} {"level":"info","ts":"2026-08-14T09:06:09.142669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=(11574285986128379461)"} {"level":"warn","ts":"2026-08-14T09:06:09.153304Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-14T09:06:09.155481Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-14T09:06:09.156919Z","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-08-14T09:06:09.159491Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a0a01fc7fbf6be45","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-14T09:06:09.159991Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a0a01fc7fbf6be45","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-14T09:06:09.160051Z","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-08-14T09:06:09.160187Z","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-08-14T09:06:09.160217Z","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-08-14T09:06:09.163393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=(11574285986128379461)"} {"level":"info","ts":"2026-08-14T09:06:09.163645Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"92fa3fee501eaaec","local-member-id":"a0a01fc7fbf6be45","added-peer-id":"a0a01fc7fbf6be45","added-peer-peer-urls":["https://199.204.45.44:2380"]} {"level":"info","ts":"2026-08-14T09:06:09.164601Z","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-08-14T09:06:09.164777Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.44:2380"} {"level":"info","ts":"2026-08-14T09:06:09.164831Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.44:2380"} {"level":"info","ts":"2026-08-14T09:06:09.164941Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a0a01fc7fbf6be45","initial-advertise-peer-urls":["https://199.204.45.44:2380"],"listen-peer-urls":["https://199.204.45.44:2380"],"advertise-client-urls":["https://199.204.45.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-14T09:06:09.165023Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-14T09:06:09.243164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 is starting a new election at term 1"} {"level":"info","ts":"2026-08-14T09:06:09.243358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-14T09:06:09.243423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 received MsgPreVoteResp from a0a01fc7fbf6be45 at term 1"} {"level":"info","ts":"2026-08-14T09:06:09.243496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became candidate at term 2"} {"level":"info","ts":"2026-08-14T09:06:09.243558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 received MsgVoteResp from a0a01fc7fbf6be45 at term 2"} {"level":"info","ts":"2026-08-14T09:06:09.2436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became leader at term 2"} {"level":"info","ts":"2026-08-14T09:06:09.243656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a0a01fc7fbf6be45 elected leader a0a01fc7fbf6be45 at term 2"} {"level":"info","ts":"2026-08-14T09:06:09.244635Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T09:06:09.245478Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a0a01fc7fbf6be45","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.44:2379]}","request-path":"/0/members/a0a01fc7fbf6be45/attributes","cluster-id":"92fa3fee501eaaec","publish-timeout":"7s"} {"level":"info","ts":"2026-08-14T09:06:09.245637Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T09:06:09.246031Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-14T09:06:09.246092Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-14T09:06:09.245685Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T09:06:09.248124Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"92fa3fee501eaaec","local-member-id":"a0a01fc7fbf6be45","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T09:06:09.248225Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T09:06:09.248264Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T09:06:09.249847Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.44:2379"} {"level":"info","ts":"2026-08-14T09:06:09.253969Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-14T09:06:29.965181Z","caller":"traceutil/trace.go:171","msg":"trace[302401976] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"356.935831ms","start":"2026-08-14T09:06:29.608206Z","end":"2026-08-14T09:06:29.965142Z","steps":["trace[302401976] 'process raft request' (duration: 356.659604ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:29.965986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:29.608173Z","time spent":"357.135016ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:06:30.592963Z","caller":"traceutil/trace.go:171","msg":"trace[1367852524] linearizableReadLoop","detail":"{readStateIndex:438; appliedIndex:436; }","duration":"867.837989ms","start":"2026-08-14T09:06:29.725097Z","end":"2026-08-14T09:06:30.592935Z","steps":["trace[1367852524] 'read index received' (duration: 239.753051ms)","trace[1367852524] 'applied index is now lower than readState.Index' (duration: 628.082768ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:06:30.593116Z","caller":"traceutil/trace.go:171","msg":"trace[97867040] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"984.554227ms","start":"2026-08-14T09:06:29.608497Z","end":"2026-08-14T09:06:30.593052Z","steps":["trace[97867040] 'process raft request' (duration: 984.289221ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:30.593249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.261728ms","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-08-14T09:06:30.593346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:29.608484Z","time spent":"984.737513ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:06:30.593412Z","caller":"traceutil/trace.go:171","msg":"trace[750701107] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:426; }","duration":"132.461603ms","start":"2026-08-14T09:06:30.460932Z","end":"2026-08-14T09:06:30.593393Z","steps":["trace[750701107] 'agreement among raft nodes before linearized reading' (duration: 132.243607ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:30.59329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"868.151177ms","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-08-14T09:06:30.593546Z","caller":"traceutil/trace.go:171","msg":"trace[1471919613] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:426; }","duration":"868.467685ms","start":"2026-08-14T09:06:29.725049Z","end":"2026-08-14T09:06:30.593516Z","steps":["trace[1471919613] 'agreement among raft nodes before linearized reading' (duration: 868.060255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:30.593604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.24195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:06:30.593609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:29.725031Z","time spent":"868.565317ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T09:06:30.59365Z","caller":"traceutil/trace.go:171","msg":"trace[1338294373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:426; }","duration":"748.798193ms","start":"2026-08-14T09:06:29.844837Z","end":"2026-08-14T09:06:30.593635Z","steps":["trace[1338294373] 'agreement among raft nodes before linearized reading' (duration: 748.263141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:30.593838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:29.844804Z","time spent":"749.023189ms","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:06:30.843439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.234011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:06:30.843709Z","caller":"traceutil/trace.go:171","msg":"trace[564173413] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"245.125481ms","start":"2026-08-14T09:06:30.598527Z","end":"2026-08-14T09:06:30.843652Z","steps":["trace[564173413] 'process raft request' (duration: 61.163983ms)","trace[564173413] 'compare' (duration: 183.110408ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:06:30.843919Z","caller":"traceutil/trace.go:171","msg":"trace[1739323946] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"243.070291ms","start":"2026-08-14T09:06:30.60083Z","end":"2026-08-14T09:06:30.8439Z","steps":["trace[1739323946] 'process raft request' (duration: 242.727603ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:06:48.240234Z","caller":"traceutil/trace.go:171","msg":"trace[236333236] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"631.129091ms","start":"2026-08-14T09:06:47.609084Z","end":"2026-08-14T09:06:48.240213Z","steps":["trace[236333236] 'process raft request' (duration: 631.030339ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.2405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.609066Z","time spent":"631.369348ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:06:48.250166Z","caller":"traceutil/trace.go:171","msg":"trace[2089130134] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"639.407244ms","start":"2026-08-14T09:06:47.610743Z","end":"2026-08-14T09:06:48.250151Z","steps":["trace[2089130134] 'process raft request' (duration: 639.311842ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:06:48.25021Z","caller":"traceutil/trace.go:171","msg":"trace[2126969679] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"639.23214ms","start":"2026-08-14T09:06:47.61095Z","end":"2026-08-14T09:06:48.250182Z","steps":["trace[2126969679] 'process raft request' (duration: 639.146878ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:06:48.250219Z","caller":"traceutil/trace.go:171","msg":"trace[1265701932] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"634.716291ms","start":"2026-08-14T09:06:47.615481Z","end":"2026-08-14T09:06:48.250197Z","steps":["trace[1265701932] 'process raft request' (duration: 634.640299ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.250282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.610718Z","time spent":"639.498686ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:06:48.25026Z","caller":"traceutil/trace.go:171","msg":"trace[732294691] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"629.085863ms","start":"2026-08-14T09:06:47.621135Z","end":"2026-08-14T09:06:48.250221Z","steps":["trace[732294691] 'process raft request' (duration: 629.008161ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.250331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.615465Z","time spent":"634.835013ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:06:48.250343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.610944Z","time spent":"639.341383ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:06:48.250406Z","caller":"traceutil/trace.go:171","msg":"trace[162852797] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"629.056422ms","start":"2026-08-14T09:06:47.621342Z","end":"2026-08-14T09:06:48.250399Z","steps":["trace[162852797] 'process raft request' (duration: 628.823567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.250399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.621116Z","time spent":"629.223126ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:06:48.250448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.621335Z","time spent":"629.097933ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:06:48.250463Z","caller":"traceutil/trace.go:171","msg":"trace[456782568] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"628.426236ms","start":"2026-08-14T09:06:47.622023Z","end":"2026-08-14T09:06:48.25045Z","steps":["trace[456782568] 'process raft request' (duration: 628.168389ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.250506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.622018Z","time spent":"628.467747ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:06:48.250526Z","caller":"traceutil/trace.go:171","msg":"trace[1010914495] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"627.76961ms","start":"2026-08-14T09:06:47.622748Z","end":"2026-08-14T09:06:48.250517Z","steps":["trace[1010914495] 'process raft request' (duration: 627.510054ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.250556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.622739Z","time spent":"627.802231ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:06:48.250603Z","caller":"traceutil/trace.go:171","msg":"trace[470043630] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"621.141729ms","start":"2026-08-14T09:06:47.629455Z","end":"2026-08-14T09:06:48.250596Z","steps":["trace[470043630] 'process raft request' (duration: 620.892113ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.250646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.629442Z","time spent":"621.18123ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:06:48.250697Z","caller":"traceutil/trace.go:171","msg":"trace[916867276] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"597.501581ms","start":"2026-08-14T09:06:47.653185Z","end":"2026-08-14T09:06:48.250686Z","steps":["trace[916867276] 'process raft request' (duration: 597.337657ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.250777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.653167Z","time spent":"597.573543ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:06:48.250787Z","caller":"traceutil/trace.go:171","msg":"trace[293788325] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"581.152703ms","start":"2026-08-14T09:06:47.669625Z","end":"2026-08-14T09:06:48.250778Z","steps":["trace[293788325] 'process raft request' (duration: 580.973658ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.250832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.669598Z","time spent":"581.209023ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:06:48.250853Z","caller":"traceutil/trace.go:171","msg":"trace[1136016806] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"464.043165ms","start":"2026-08-14T09:06:47.786802Z","end":"2026-08-14T09:06:48.250846Z","steps":["trace[1136016806] 'process raft request' (duration: 463.885811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.250906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.786772Z","time spent":"464.118147ms","remote":"127.0.0.1:60408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:06:48.264989Z","caller":"traceutil/trace.go:171","msg":"trace[674853233] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:548; }","duration":"419.140978ms","start":"2026-08-14T09:06:47.845836Z","end":"2026-08-14T09:06:48.264977Z","steps":["trace[674853233] 'read index received' (duration: 394.215919ms)","trace[674853233] 'applied index is now lower than readState.Index' (duration: 24.924459ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:06:48.265325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.480947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:06:48.265549Z","caller":"traceutil/trace.go:171","msg":"trace[1304752978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:544; }","duration":"419.771103ms","start":"2026-08-14T09:06:47.845768Z","end":"2026-08-14T09:06:48.265539Z","steps":["trace[1304752978] 'agreement among raft nodes before linearized reading' (duration: 419.522567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:48.265599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:47.845749Z","time spent":"419.843126ms","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:06:48.26915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.538428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-08-14T09:06:48.269237Z","caller":"traceutil/trace.go:171","msg":"trace[1741056747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:549; }","duration":"192.678232ms","start":"2026-08-14T09:06:48.076539Z","end":"2026-08-14T09:06:48.269218Z","steps":["trace[1741056747] 'agreement among raft nodes before linearized reading' (duration: 192.552989ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:06:55.155098Z","caller":"traceutil/trace.go:171","msg":"trace[1887913984] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"340.9777ms","start":"2026-08-14T09:06:54.814092Z","end":"2026-08-14T09:06:55.15507Z","steps":["trace[1887913984] 'read index received' (duration: 340.891628ms)","trace[1887913984] 'applied index is now lower than readState.Index' (duration: 84.302µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:06:55.155143Z","caller":"traceutil/trace.go:171","msg":"trace[1834794758] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"408.379689ms","start":"2026-08-14T09:06:54.746732Z","end":"2026-08-14T09:06:55.155112Z","steps":["trace[1834794758] 'process raft request' (duration: 408.171884ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:55.155294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:54.746683Z","time spent":"408.536823ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:06:55.155423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.303269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2xbj9\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-08-14T09:06:55.155518Z","caller":"traceutil/trace.go:171","msg":"trace[852518916] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2xbj9; range_end:; response_count:1; response_revision:632; }","duration":"341.445212ms","start":"2026-08-14T09:06:54.81404Z","end":"2026-08-14T09:06:55.155486Z","steps":["trace[852518916] 'agreement among raft nodes before linearized reading' (duration: 341.147525ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:55.155561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:54.81402Z","time spent":"341.531464ms","remote":"127.0.0.1:60504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-2xbj9\" "} {"level":"warn","ts":"2026-08-14T09:06:55.655592Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13710540560405134201,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T09:06:55.966677Z","caller":"traceutil/trace.go:171","msg":"trace[1601201179] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"1.044468884s","start":"2026-08-14T09:06:54.922185Z","end":"2026-08-14T09:06:55.966653Z","steps":["trace[1601201179] 'process raft request' (duration: 1.042814064s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:55.967169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:54.922157Z","time spent":"1.044591147s","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:06:56.692449Z","caller":"traceutil/trace.go:171","msg":"trace[1941554500] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.523709157s","start":"2026-08-14T09:06:55.168711Z","end":"2026-08-14T09:06:56.69242Z","steps":["trace[1941554500] 'process raft request' (duration: 1.455617321s)","trace[1941554500] 'compare' (duration: 67.922522ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:06:56.692582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:55.168676Z","time spent":"1.523844941s","remote":"127.0.0.1:60504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:06:56.692652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.847424041s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:06:56.692696Z","caller":"traceutil/trace.go:171","msg":"trace[1679461738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"1.847492113s","start":"2026-08-14T09:06:54.845192Z","end":"2026-08-14T09:06:56.692684Z","steps":["trace[1679461738] 'agreement among raft nodes before linearized reading' (duration: 1.847414521s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:06:56.692694Z","caller":"traceutil/trace.go:171","msg":"trace[965269467] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.171993272s","start":"2026-08-14T09:06:55.520676Z","end":"2026-08-14T09:06:56.69267Z","steps":["trace[965269467] 'process raft request' (duration: 1.171695574s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:56.692837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.731758169s","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-08-14T09:06:56.692584Z","caller":"traceutil/trace.go:171","msg":"trace[127626523] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:657; }","duration":"1.537361716s","start":"2026-08-14T09:06:55.155184Z","end":"2026-08-14T09:06:56.692546Z","steps":["trace[127626523] 'read index received' (duration: 808.833361ms)","trace[127626523] 'applied index is now lower than readState.Index' (duration: 728.527585ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:06:56.692864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:55.52065Z","time spent":"1.172126445s","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:06:56.692866Z","caller":"traceutil/trace.go:171","msg":"trace[218007326] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"1.731807299s","start":"2026-08-14T09:06:54.96105Z","end":"2026-08-14T09:06:56.692857Z","steps":["trace[218007326] 'agreement among raft nodes before linearized reading' (duration: 1.731712347s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:56.692743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:54.845177Z","time spent":"1.847559204s","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:06:56.692933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.73223524s","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-08-14T09:06:56.692959Z","caller":"traceutil/trace.go:171","msg":"trace[1800449327] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"1.732300022s","start":"2026-08-14T09:06:54.960652Z","end":"2026-08-14T09:06:56.692952Z","steps":["trace[1800449327] 'agreement among raft nodes before linearized reading' (duration: 1.73222834s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:56.692989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:54.96063Z","time spent":"1.732352523s","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T09:06:56.692963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:54.961041Z","time spent":"1.731884611s","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T09:06:56.740849Z","caller":"traceutil/trace.go:171","msg":"trace[938913826] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"715.153683ms","start":"2026-08-14T09:06:56.025659Z","end":"2026-08-14T09:06:56.740813Z","steps":["trace[938913826] 'process raft request' (duration: 714.857656ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:56.741029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:56.025621Z","time spent":"715.316167ms","remote":"127.0.0.1:60640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:06:56.741093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.360799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-14T09:06:56.741218Z","caller":"traceutil/trace.go:171","msg":"trace[516414352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"408.559604ms","start":"2026-08-14T09:06:56.332619Z","end":"2026-08-14T09:06:56.741178Z","steps":["trace[516414352] 'agreement among raft nodes before linearized reading' (duration: 408.220966ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:56.741275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:56.332598Z","time spent":"408.666226ms","remote":"127.0.0.1:60576","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-08-14T09:06:56.863364Z","caller":"traceutil/trace.go:171","msg":"trace[1565734133] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"118.048282ms","start":"2026-08-14T09:06:56.745279Z","end":"2026-08-14T09:06:56.863327Z","steps":["trace[1565734133] 'process raft request' (duration: 69.789288ms)","trace[1565734133] 'compare' (duration: 48.039729ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:06:56.8634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.098766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:06:56.863527Z","caller":"traceutil/trace.go:171","msg":"trace[1458307050] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:639; }","duration":"112.245659ms","start":"2026-08-14T09:06:56.751207Z","end":"2026-08-14T09:06:56.863453Z","steps":["trace[1458307050] 'agreement among raft nodes before linearized reading' (duration: 112.062384ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:58.344616Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13710540560405134213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:06:58.791412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.631183908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-14T09:06:58.791508Z","caller":"traceutil/trace.go:171","msg":"trace[206631481] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"1.631321072s","start":"2026-08-14T09:06:57.160167Z","end":"2026-08-14T09:06:58.791488Z","steps":["trace[206631481] 'range keys from in-memory index tree' (duration: 1.631002074s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:58.791549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:57.160149Z","time spent":"1.631389673s","remote":"127.0.0.1:60576","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-08-14T09:06:58.84482Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13710540560405134213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:06:58.861478Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.61552414s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T09:06:58.862535Z","caller":"traceutil/trace.go:171","msg":"trace[1032523009] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.618284239s","start":"2026-08-14T09:06:57.244225Z","end":"2026-08-14T09:06:58.862509Z","steps":["trace[1032523009] 'process raft request' (duration: 1.617728375s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:58.8627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:57.244196Z","time spent":"1.618419612s","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:06:58.90063Z","caller":"traceutil/trace.go:171","msg":"trace[1399420990] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:664; }","duration":"1.056540453s","start":"2026-08-14T09:06:57.844043Z","end":"2026-08-14T09:06:58.900584Z","steps":["trace[1399420990] 'read index received' (duration: 1.017695211s)","trace[1399420990] 'applied index is now lower than readState.Index' (duration: 38.844232ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:06:58.901647Z","caller":"traceutil/trace.go:171","msg":"trace[65611996] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"105.627625ms","start":"2026-08-14T09:06:58.795986Z","end":"2026-08-14T09:06:58.901614Z","steps":["trace[65611996] 'process raft request' (duration: 104.409715ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:58.932557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.213287ms","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-08-14T09:06:58.932614Z","caller":"traceutil/trace.go:171","msg":"trace[1483350743] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"139.371661ms","start":"2026-08-14T09:06:58.793228Z","end":"2026-08-14T09:06:58.9326Z","steps":["trace[1483350743] 'agreement among raft nodes before linearized reading' (duration: 108.849865ms)","trace[1483350743] 'range keys from in-memory index tree' (duration: 30.374792ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:06:58.932824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.61591ms","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-08-14T09:06:58.93283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.08873528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:06:58.932879Z","caller":"traceutil/trace.go:171","msg":"trace[1639876578] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:641; }","duration":"140.717663ms","start":"2026-08-14T09:06:58.792149Z","end":"2026-08-14T09:06:58.932866Z","steps":["trace[1639876578] 'agreement among raft nodes before linearized reading' (duration: 109.89912ms)","trace[1639876578] 'range keys from in-memory index tree' (duration: 30.419773ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:06:58.933032Z","caller":"traceutil/trace.go:171","msg":"trace[1953529804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"1.088949865s","start":"2026-08-14T09:06:57.843993Z","end":"2026-08-14T09:06:58.932943Z","steps":["trace[1953529804] 'agreement among raft nodes before linearized reading' (duration: 1.058068261s)","trace[1953529804] 'range keys from in-memory index tree' (duration: 30.505905ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:06:58.933097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:06:57.843972Z","time spent":"1.089114548s","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:07:15.857372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.854664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-14T09:07:15.857427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.392987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-14T09:07:15.857432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.411918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-08-14T09:07:15.857488Z","caller":"traceutil/trace.go:171","msg":"trace[58065132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:808; }","duration":"803.025089ms","start":"2026-08-14T09:07:15.054436Z","end":"2026-08-14T09:07:15.857461Z","steps":["trace[58065132] 'range keys from in-memory index tree' (duration: 802.661239ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:15.857495Z","caller":"traceutil/trace.go:171","msg":"trace[1973473640] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:808; }","duration":"801.49208ms","start":"2026-08-14T09:07:15.055986Z","end":"2026-08-14T09:07:15.857478Z","steps":["trace[1973473640] 'range keys from in-memory index tree' (duration: 801.262644ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:15.857513Z","caller":"traceutil/trace.go:171","msg":"trace[650785061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:808; }","duration":"803.5187ms","start":"2026-08-14T09:07:15.053979Z","end":"2026-08-14T09:07:15.857498Z","steps":["trace[650785061] 'range keys from in-memory index tree' (duration: 803.270744ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:15.857534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:07:15.055974Z","time spent":"801.551001ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T09:07:15.857538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:07:15.054413Z","time spent":"803.11332ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T09:07:15.85755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:07:15.053923Z","time spent":"803.619243ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T09:07:15.857578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.019708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-14T09:07:15.857663Z","caller":"traceutil/trace.go:171","msg":"trace[970495556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:808; }","duration":"887.149541ms","start":"2026-08-14T09:07:14.970492Z","end":"2026-08-14T09:07:15.857642Z","steps":["trace[970495556] 'range keys from in-memory index tree' (duration: 886.850264ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:15.857721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.63944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-sm4g4\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-08-14T09:07:15.857729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:07:14.970473Z","time spent":"887.236633ms","remote":"127.0.0.1:60576","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-08-14T09:07:15.857792Z","caller":"traceutil/trace.go:171","msg":"trace[1189552609] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-sm4g4; range_end:; response_count:1; response_revision:808; }","duration":"937.736503ms","start":"2026-08-14T09:07:14.920012Z","end":"2026-08-14T09:07:15.857748Z","steps":["trace[1189552609] 'range keys from in-memory index tree' (duration: 937.516087ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:15.857816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:07:14.919989Z","time spent":"937.820745ms","remote":"127.0.0.1:60504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-sm4g4\" "} {"level":"info","ts":"2026-08-14T09:07:15.972454Z","caller":"traceutil/trace.go:171","msg":"trace[345775018] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"316.393062ms","start":"2026-08-14T09:07:15.656037Z","end":"2026-08-14T09:07:15.97243Z","steps":["trace[345775018] 'process raft request' (duration: 316.232288ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:15.97268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:07:15.656017Z","time spent":"316.589737ms","remote":"127.0.0.1:60502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5051,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:07:15.979604Z","caller":"traceutil/trace.go:171","msg":"trace[143213624] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"117.415736ms","start":"2026-08-14T09:07:15.86218Z","end":"2026-08-14T09:07:15.979596Z","steps":["trace[143213624] 'process raft request' (duration: 117.332354ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:15.979805Z","caller":"traceutil/trace.go:171","msg":"trace[863183407] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"117.418365ms","start":"2026-08-14T09:07:15.862379Z","end":"2026-08-14T09:07:15.979798Z","steps":["trace[863183407] 'process raft request' (duration: 117.190989ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:15.980124Z","caller":"traceutil/trace.go:171","msg":"trace[1910318077] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"117.649602ms","start":"2026-08-14T09:07:15.862456Z","end":"2026-08-14T09:07:15.980105Z","steps":["trace[1910318077] 'process raft request' (duration: 117.293063ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:15.980417Z","caller":"traceutil/trace.go:171","msg":"trace[352759705] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"117.104989ms","start":"2026-08-14T09:07:15.863302Z","end":"2026-08-14T09:07:15.980407Z","steps":["trace[352759705] 'process raft request' (duration: 116.74168ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:15.980517Z","caller":"traceutil/trace.go:171","msg":"trace[55503734] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"114.188507ms","start":"2026-08-14T09:07:15.8663Z","end":"2026-08-14T09:07:15.980489Z","steps":["trace[55503734] 'process raft request' (duration: 113.961551ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:30.310515Z","caller":"traceutil/trace.go:171","msg":"trace[2028122867] linearizableReadLoop","detail":"{readStateIndex:981; appliedIndex:979; }","duration":"262.617701ms","start":"2026-08-14T09:07:30.047872Z","end":"2026-08-14T09:07:30.31049Z","steps":["trace[2028122867] 'read index received' (duration: 35.320134ms)","trace[2028122867] 'applied index is now lower than readState.Index' (duration: 227.296597ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:07:30.310697Z","caller":"traceutil/trace.go:171","msg":"trace[1222693998] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"263.547104ms","start":"2026-08-14T09:07:30.047121Z","end":"2026-08-14T09:07:30.310668Z","steps":["trace[1222693998] 'process raft request' (duration: 226.846316ms)","trace[1222693998] 'compare' (duration: 36.34909ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:07:30.310741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.858677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-14T09:07:30.310748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.970061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:07:30.310794Z","caller":"traceutil/trace.go:171","msg":"trace[1255558694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:947; }","duration":"262.932269ms","start":"2026-08-14T09:07:30.04785Z","end":"2026-08-14T09:07:30.310782Z","steps":["trace[1255558694] 'agreement among raft nodes before linearized reading' (duration: 262.795306ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:07:30.310814Z","caller":"traceutil/trace.go:171","msg":"trace[769161686] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:947; }","duration":"156.103494ms","start":"2026-08-14T09:07:30.154692Z","end":"2026-08-14T09:07:30.310796Z","steps":["trace[769161686] 'agreement among raft nodes before linearized reading' (duration: 155.996202ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:31.087038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.583201ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:07:31.087123Z","caller":"traceutil/trace.go:171","msg":"trace[5340500] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:981; }","duration":"699.408773ms","start":"2026-08-14T09:07:30.387701Z","end":"2026-08-14T09:07:31.08711Z","steps":["trace[5340500] 'read index received' (duration: 32.606507ms)","trace[5340500] 'applied index is now lower than readState.Index' (duration: 666.801136ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:07:31.087162Z","caller":"traceutil/trace.go:171","msg":"trace[1243156213] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"773.353133ms","start":"2026-08-14T09:07:30.313778Z","end":"2026-08-14T09:07:31.087131Z","steps":["trace[1243156213] 'process raft request' (duration: 106.603849ms)","trace[1243156213] 'compare' (duration: 666.298323ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:07:31.087272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.569897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-qz2nf\" ","response":"range_response_count:1 size:5676"} {"level":"info","ts":"2026-08-14T09:07:31.087293Z","caller":"traceutil/trace.go:171","msg":"trace[1804264736] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-qz2nf; range_end:; response_count:1; response_revision:948; }","duration":"699.629778ms","start":"2026-08-14T09:07:30.387655Z","end":"2026-08-14T09:07:31.087285Z","steps":["trace[1804264736] 'agreement among raft nodes before linearized reading' (duration: 699.517675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:31.087315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:07:30.387633Z","time spent":"699.676939ms","remote":"127.0.0.1:60504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":5700,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-qz2nf\" "} {"level":"warn","ts":"2026-08-14T09:07:31.087316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:07:30.313759Z","time spent":"773.472276ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:07:31.106351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.734769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:07:31.106415Z","caller":"traceutil/trace.go:171","msg":"trace[2102141960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:949; }","duration":"261.833651ms","start":"2026-08-14T09:07:30.844567Z","end":"2026-08-14T09:07:31.106401Z","steps":["trace[2102141960] 'agreement among raft nodes before linearized reading' (duration: 261.738339ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:31.106796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.559546ms","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-08-14T09:07:31.106875Z","caller":"traceutil/trace.go:171","msg":"trace[442090087] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:949; }","duration":"478.676999ms","start":"2026-08-14T09:07:30.628186Z","end":"2026-08-14T09:07:31.106863Z","steps":["trace[442090087] 'agreement among raft nodes before linearized reading' (duration: 478.034743ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:31.106909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:07:30.628168Z","time spent":"478.730961ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-14T09:07:37.955886Z","caller":"traceutil/trace.go:171","msg":"trace[872691852] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1016; }","duration":"112.410452ms","start":"2026-08-14T09:07:37.843458Z","end":"2026-08-14T09:07:37.955869Z","steps":["trace[872691852] 'read index received' (duration: 112.29586ms)","trace[872691852] 'applied index is now lower than readState.Index' (duration: 113.752µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:07:37.955983Z","caller":"traceutil/trace.go:171","msg":"trace[1054747783] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"382.088668ms","start":"2026-08-14T09:07:37.573887Z","end":"2026-08-14T09:07:37.955976Z","steps":["trace[1054747783] 'process raft request' (duration: 381.869423ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:07:37.956061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:07:37.573864Z","time spent":"382.13579ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:07:37.956289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.829313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:07:37.956319Z","caller":"traceutil/trace.go:171","msg":"trace[1775132974] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:981; }","duration":"112.887194ms","start":"2026-08-14T09:07:37.843423Z","end":"2026-08-14T09:07:37.95631Z","steps":["trace[1775132974] 'agreement among raft nodes before linearized reading' (duration: 112.845973ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:02.484451Z","caller":"traceutil/trace.go:171","msg":"trace[1450713098] linearizableReadLoop","detail":"{readStateIndex:1106; appliedIndex:1105; }","duration":"163.415323ms","start":"2026-08-14T09:08:02.321008Z","end":"2026-08-14T09:08:02.484424Z","steps":["trace[1450713098] 'read index received' (duration: 163.209778ms)","trace[1450713098] 'applied index is now lower than readState.Index' (duration: 204.595µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:08:02.484773Z","caller":"traceutil/trace.go:171","msg":"trace[1899846697] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"190.95129ms","start":"2026-08-14T09:08:02.293806Z","end":"2026-08-14T09:08:02.484757Z","steps":["trace[1899846697] 'process raft request' (duration: 190.475248ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:02.485108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.08733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-14T09:08:02.485175Z","caller":"traceutil/trace.go:171","msg":"trace[1151690952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1064; }","duration":"164.184763ms","start":"2026-08-14T09:08:02.320974Z","end":"2026-08-14T09:08:02.485159Z","steps":["trace[1151690952] 'agreement among raft nodes before linearized reading' (duration: 164.051009ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:02.988369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.050616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:08:02.988484Z","caller":"traceutil/trace.go:171","msg":"trace[1751661403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1066; }","duration":"143.21805ms","start":"2026-08-14T09:08:02.84524Z","end":"2026-08-14T09:08:02.988458Z","steps":["trace[1751661403] 'range keys from in-memory index tree' (duration: 142.976194ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:02.988548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.351024ms","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-08-14T09:08:02.988649Z","caller":"traceutil/trace.go:171","msg":"trace[514663907] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1066; }","duration":"139.505138ms","start":"2026-08-14T09:08:02.849123Z","end":"2026-08-14T09:08:02.988628Z","steps":["trace[514663907] 'count revisions from in-memory index tree' (duration: 139.288822ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:03.791021Z","caller":"traceutil/trace.go:171","msg":"trace[1313267512] linearizableReadLoop","detail":"{readStateIndex:1111; appliedIndex:1110; }","duration":"491.947863ms","start":"2026-08-14T09:08:03.299046Z","end":"2026-08-14T09:08:03.790994Z","steps":["trace[1313267512] 'read index received' (duration: 396.974486ms)","trace[1313267512] 'applied index is now lower than readState.Index' (duration: 94.972207ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:08:03.791322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.256621ms","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-08-14T09:08:03.791236Z","caller":"traceutil/trace.go:171","msg":"trace[1188191075] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"512.805804ms","start":"2026-08-14T09:08:03.27839Z","end":"2026-08-14T09:08:03.791196Z","steps":["trace[1188191075] 'process raft request' (duration: 417.664732ms)","trace[1188191075] 'compare' (duration: 94.541036ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:08:03.791395Z","caller":"traceutil/trace.go:171","msg":"trace[1175436645] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1068; }","duration":"492.373354ms","start":"2026-08-14T09:08:03.299009Z","end":"2026-08-14T09:08:03.791383Z","steps":["trace[1175436645] 'agreement among raft nodes before linearized reading' (duration: 492.17559ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:03.792108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:03.278364Z","time spent":"513.658215ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:08:03.792211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:03.298997Z","time spent":"493.187534ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T09:08:03.845881Z","caller":"traceutil/trace.go:171","msg":"trace[1304014297] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"336.555839ms","start":"2026-08-14T09:08:03.509296Z","end":"2026-08-14T09:08:03.845851Z","steps":["trace[1304014297] 'process raft request' (duration: 336.381775ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:03.846049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:03.509267Z","time spent":"336.685243ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:08:03.846264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.752386ms","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-08-14T09:08:03.846318Z","caller":"traceutil/trace.go:171","msg":"trace[828812613] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1069; }","duration":"523.825248ms","start":"2026-08-14T09:08:03.32248Z","end":"2026-08-14T09:08:03.846305Z","steps":["trace[828812613] 'agreement among raft nodes before linearized reading' (duration: 523.452488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:03.846429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:03.322398Z","time spent":"524.018502ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T09:08:04.068186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.082126ms","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-08-14T09:08:04.068335Z","caller":"traceutil/trace.go:171","msg":"trace[488136573] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1070; }","duration":"145.24446ms","start":"2026-08-14T09:08:03.923067Z","end":"2026-08-14T09:08:04.068312Z","steps":["trace[488136573] 'range keys from in-memory index tree' (duration: 145.066325ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:04.068254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.63483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:08:04.068853Z","caller":"traceutil/trace.go:171","msg":"trace[563921699] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"217.962813ms","start":"2026-08-14T09:08:03.850743Z","end":"2026-08-14T09:08:04.068706Z","steps":["trace[563921699] 'process raft request' (duration: 71.805309ms)","trace[563921699] 'compare' (duration: 145.538288ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:08:18.843804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.324453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:08:18.843893Z","caller":"traceutil/trace.go:171","msg":"trace[1876239311] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1171; }","duration":"135.466727ms","start":"2026-08-14T09:08:18.708408Z","end":"2026-08-14T09:08:18.843875Z","steps":["trace[1876239311] 'count revisions from in-memory index tree' (duration: 135.260911ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:21.882145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037152063s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:08:21.882256Z","caller":"traceutil/trace.go:171","msg":"trace[1598637406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1174; }","duration":"1.037307097s","start":"2026-08-14T09:08:20.844922Z","end":"2026-08-14T09:08:21.88223Z","steps":["trace[1598637406] 'range keys from in-memory index tree' (duration: 1.037060651s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:21.882252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.246215604s","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-08-14T09:08:21.882313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:20.8449Z","time spent":"1.03739886s","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T09:08:21.882339Z","caller":"traceutil/trace.go:171","msg":"trace[1581960137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1174; }","duration":"1.246358807s","start":"2026-08-14T09:08:20.635959Z","end":"2026-08-14T09:08:21.882318Z","steps":["trace[1581960137] 'range keys from in-memory index tree' (duration: 1.24604006s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:21.882384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:20.635946Z","time spent":"1.24642853s","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T09:08:21.882408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.685039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:08:21.882471Z","caller":"traceutil/trace.go:171","msg":"trace[2080150330] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1174; }","duration":"581.784463ms","start":"2026-08-14T09:08:21.30067Z","end":"2026-08-14T09:08:21.882454Z","steps":["trace[2080150330] 'count revisions from in-memory index tree' (duration: 581.559307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:21.882505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:21.300655Z","time spent":"581.840764ms","remote":"127.0.0.1:59054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:08:21.882854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079259344s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:08:21.882894Z","caller":"traceutil/trace.go:171","msg":"trace[173250171] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1174; }","duration":"1.079339716s","start":"2026-08-14T09:08:20.803542Z","end":"2026-08-14T09:08:21.882882Z","steps":["trace[173250171] 'count revisions from in-memory index tree' (duration: 1.079166942s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:21.882931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:20.803521Z","time spent":"1.079401337s","remote":"127.0.0.1:60538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:08:21.883113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.224163006s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-14T09:08:21.883143Z","caller":"traceutil/trace.go:171","msg":"trace[1003850433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1174; }","duration":"1.224211366s","start":"2026-08-14T09:08:20.658921Z","end":"2026-08-14T09:08:21.883132Z","steps":["trace[1003850433] 'range keys from in-memory index tree' (duration: 1.224059653s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:21.883118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220167177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-14T09:08:21.883165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:20.658908Z","time spent":"1.224252057s","remote":"127.0.0.1:60576","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-08-14T09:08:21.883192Z","caller":"traceutil/trace.go:171","msg":"trace[1256684621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1174; }","duration":"1.220294629s","start":"2026-08-14T09:08:20.662878Z","end":"2026-08-14T09:08:21.883173Z","steps":["trace[1256684621] 'range keys from in-memory index tree' (duration: 1.220030582s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:21.883231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:20.662868Z","time spent":"1.220353491s","remote":"127.0.0.1:60576","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-08-14T09:08:34.205037Z","caller":"traceutil/trace.go:171","msg":"trace[755357127] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1265; }","duration":"218.737102ms","start":"2026-08-14T09:08:33.986274Z","end":"2026-08-14T09:08:34.205011Z","steps":["trace[755357127] 'read index received' (duration: 218.414144ms)","trace[755357127] 'applied index is now lower than readState.Index' (duration: 321.918µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:08:34.205127Z","caller":"traceutil/trace.go:171","msg":"trace[1636497472] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"233.661744ms","start":"2026-08-14T09:08:33.971424Z","end":"2026-08-14T09:08:34.205085Z","steps":["trace[1636497472] 'process raft request' (duration: 233.387637ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:34.205308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.003549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-14T09:08:34.205378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.293707ms","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-08-14T09:08:34.205401Z","caller":"traceutil/trace.go:171","msg":"trace[278952253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1215; }","duration":"219.139542ms","start":"2026-08-14T09:08:33.986236Z","end":"2026-08-14T09:08:34.205375Z","steps":["trace[278952253] 'agreement among raft nodes before linearized reading' (duration: 218.880696ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:34.205436Z","caller":"traceutil/trace.go:171","msg":"trace[300246745] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1215; }","duration":"211.375469ms","start":"2026-08-14T09:08:33.994049Z","end":"2026-08-14T09:08:34.205425Z","steps":["trace[300246745] 'agreement among raft nodes before linearized reading' (duration: 211.228355ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:34.20546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.096544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-14T09:08:34.205477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.34499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-08-14T09:08:34.205507Z","caller":"traceutil/trace.go:171","msg":"trace[2110219308] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1215; }","duration":"122.204596ms","start":"2026-08-14T09:08:34.083286Z","end":"2026-08-14T09:08:34.205491Z","steps":["trace[2110219308] 'agreement among raft nodes before linearized reading' (duration: 122.020472ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:34.205533Z","caller":"traceutil/trace.go:171","msg":"trace[18696906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1215; }","duration":"177.442963ms","start":"2026-08-14T09:08:34.028075Z","end":"2026-08-14T09:08:34.205518Z","steps":["trace[18696906] 'agreement among raft nodes before linearized reading' (duration: 177.234478ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:38.471027Z","caller":"traceutil/trace.go:171","msg":"trace[2065914383] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"175.70754ms","start":"2026-08-14T09:08:38.295296Z","end":"2026-08-14T09:08:38.471004Z","steps":["trace[2065914383] 'process raft request' (duration: 175.601768ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:38.471064Z","caller":"traceutil/trace.go:171","msg":"trace[1430332841] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"176.741016ms","start":"2026-08-14T09:08:38.294278Z","end":"2026-08-14T09:08:38.471019Z","steps":["trace[1430332841] 'process raft request' (duration: 176.532731ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:38.471243Z","caller":"traceutil/trace.go:171","msg":"trace[1459151834] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"176.867239ms","start":"2026-08-14T09:08:38.294367Z","end":"2026-08-14T09:08:38.471234Z","steps":["trace[1459151834] 'process raft request' (duration: 176.49198ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:38.471409Z","caller":"traceutil/trace.go:171","msg":"trace[1252199639] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"178.558261ms","start":"2026-08-14T09:08:38.292839Z","end":"2026-08-14T09:08:38.471397Z","steps":["trace[1252199639] 'process raft request' (duration: 96.044175ms)","trace[1252199639] 'compare' (duration: 81.720076ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:08:38.471495Z","caller":"traceutil/trace.go:171","msg":"trace[845130542] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"177.280059ms","start":"2026-08-14T09:08:38.294206Z","end":"2026-08-14T09:08:38.471487Z","steps":["trace[845130542] 'process raft request' (duration: 176.551261ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:38.471551Z","caller":"traceutil/trace.go:171","msg":"trace[2140560013] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1303; }","duration":"147.350253ms","start":"2026-08-14T09:08:38.324191Z","end":"2026-08-14T09:08:38.471541Z","steps":["trace[2140560013] 'read index received' (duration: 64.697333ms)","trace[2140560013] 'applied index is now lower than readState.Index' (duration: 82.651369ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:08:38.501647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.404132ms","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-08-14T09:08:38.50176Z","caller":"traceutil/trace.go:171","msg":"trace[1586690613] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1257; }","duration":"177.586976ms","start":"2026-08-14T09:08:38.324142Z","end":"2026-08-14T09:08:38.501729Z","steps":["trace[1586690613] 'agreement among raft nodes before linearized reading' (duration: 147.426554ms)","trace[1586690613] 'range keys from in-memory index tree' (duration: 29.833135ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:08:39.086212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.334456ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:08:39.08639Z","caller":"traceutil/trace.go:171","msg":"trace[982310838] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1310; }","duration":"360.178588ms","start":"2026-08-14T09:08:38.726199Z","end":"2026-08-14T09:08:39.086378Z","steps":["trace[982310838] 'read index received' (duration: 185.622386ms)","trace[982310838] 'applied index is now lower than readState.Index' (duration: 174.555352ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:08:39.086472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.285871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:08:39.086485Z","caller":"traceutil/trace.go:171","msg":"trace[132238144] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1261; }","duration":"360.352783ms","start":"2026-08-14T09:08:38.726127Z","end":"2026-08-14T09:08:39.08648Z","steps":["trace[132238144] 'agreement among raft nodes before linearized reading' (duration: 360.281401ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:39.086505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:38.726101Z","time spent":"360.398254ms","remote":"127.0.0.1:60522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":31,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:08:39.086638Z","caller":"traceutil/trace.go:171","msg":"trace[531637314] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"580.553332ms","start":"2026-08-14T09:08:38.506077Z","end":"2026-08-14T09:08:39.08663Z","steps":["trace[531637314] 'process raft request' (duration: 405.730553ms)","trace[531637314] 'compare' (duration: 174.092751ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:08:39.086666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:38.506056Z","time spent":"580.594822ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:39.08679Z","caller":"traceutil/trace.go:171","msg":"trace[1687088131] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"579.498815ms","start":"2026-08-14T09:08:38.507287Z","end":"2026-08-14T09:08:39.086785Z","steps":["trace[1687088131] 'process raft request' (duration: 579.008443ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:39.086816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:38.507256Z","time spent":"579.544657ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:39.086881Z","caller":"traceutil/trace.go:171","msg":"trace[1951259753] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"228.660751ms","start":"2026-08-14T09:08:38.858217Z","end":"2026-08-14T09:08:39.086878Z","steps":["trace[1951259753] 'process raft request' (duration: 228.136878ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:40.781587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.469801ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:08:40.781803Z","caller":"traceutil/trace.go:171","msg":"trace[932478531] linearizableReadLoop","detail":"{readStateIndex:1318; appliedIndex:1315; }","duration":"186.039657ms","start":"2026-08-14T09:08:40.595746Z","end":"2026-08-14T09:08:40.781785Z","steps":["trace[932478531] 'read index received' (duration: 28.371µs)","trace[932478531] 'applied index is now lower than readState.Index' (duration: 186.010336ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:08:40.781908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.15301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:08:40.781944Z","caller":"traceutil/trace.go:171","msg":"trace[1214804327] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1266; }","duration":"186.218032ms","start":"2026-08-14T09:08:40.595716Z","end":"2026-08-14T09:08:40.781934Z","steps":["trace[1214804327] 'agreement among raft nodes before linearized reading' (duration: 186.12755ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:40.782265Z","caller":"traceutil/trace.go:171","msg":"trace[1309838959] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"303.076705ms","start":"2026-08-14T09:08:40.479175Z","end":"2026-08-14T09:08:40.782252Z","steps":["trace[1309838959] 'process raft request' (duration: 90.859585ms)","trace[1309838959] 'compare' (duration: 211.162194ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:08:40.782338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:40.479158Z","time spent":"303.144286ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:40.78247Z","caller":"traceutil/trace.go:171","msg":"trace[1929357448] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"302.996983ms","start":"2026-08-14T09:08:40.479464Z","end":"2026-08-14T09:08:40.782461Z","steps":["trace[1929357448] 'process raft request' (duration: 302.220144ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:40.782542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:40.479455Z","time spent":"303.044324ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:40.782664Z","caller":"traceutil/trace.go:171","msg":"trace[1887011916] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"303.143747ms","start":"2026-08-14T09:08:40.479512Z","end":"2026-08-14T09:08:40.782656Z","steps":["trace[1887011916] 'process raft request' (duration: 302.224574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:40.78272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:40.479505Z","time spent":"303.188238ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:46.857678Z","caller":"traceutil/trace.go:171","msg":"trace[384095527] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1349; }","duration":"342.697103ms","start":"2026-08-14T09:08:46.514964Z","end":"2026-08-14T09:08:46.857661Z","steps":["trace[384095527] 'read index received' (duration: 342.534009ms)","trace[384095527] 'applied index is now lower than readState.Index' (duration: 162.254µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:08:46.857748Z","caller":"traceutil/trace.go:171","msg":"trace[363707435] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"524.150386ms","start":"2026-08-14T09:08:46.333574Z","end":"2026-08-14T09:08:46.857724Z","steps":["trace[363707435] 'process raft request' (duration: 523.981182ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:46.857892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.916038ms","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-08-14T09:08:46.857974Z","caller":"traceutil/trace.go:171","msg":"trace[1164195362] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1297; }","duration":"343.043382ms","start":"2026-08-14T09:08:46.514909Z","end":"2026-08-14T09:08:46.857953Z","steps":["trace[1164195362] 'agreement among raft nodes before linearized reading' (duration: 342.828877ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:46.85802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:46.514888Z","time spent":"343.124223ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T09:08:46.858552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:46.333547Z","time spent":"524.911164ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:47.192953Z","caller":"traceutil/trace.go:171","msg":"trace[959577332] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"330.468678ms","start":"2026-08-14T09:08:46.862438Z","end":"2026-08-14T09:08:47.192907Z","steps":["trace[959577332] 'process raft request' (duration: 329.860712ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:47.193114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:46.862421Z","time spent":"330.609491ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:47.198094Z","caller":"traceutil/trace.go:171","msg":"trace[1671207128] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"335.100113ms","start":"2026-08-14T09:08:46.862981Z","end":"2026-08-14T09:08:47.198082Z","steps":["trace[1671207128] 'process raft request' (duration: 334.97844ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:47.198154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:46.862964Z","time spent":"335.163534ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:47.198326Z","caller":"traceutil/trace.go:171","msg":"trace[437529364] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"334.509078ms","start":"2026-08-14T09:08:46.86379Z","end":"2026-08-14T09:08:47.198299Z","steps":["trace[437529364] 'process raft request' (duration: 334.261822ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:47.19848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:46.863779Z","time spent":"334.621451ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:47.19869Z","caller":"traceutil/trace.go:171","msg":"trace[1626744814] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"334.338455ms","start":"2026-08-14T09:08:46.864342Z","end":"2026-08-14T09:08:47.198681Z","steps":["trace[1626744814] 'process raft request' (duration: 333.868152ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:08:47.198735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:08:46.864298Z","time spent":"334.415346ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:08:49.287522Z","caller":"traceutil/trace.go:171","msg":"trace[696527126] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"183.318399ms","start":"2026-08-14T09:08:49.104177Z","end":"2026-08-14T09:08:49.287496Z","steps":["trace[696527126] 'process raft request' (duration: 138.877241ms)","trace[696527126] 'compare' (duration: 44.172691ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:08:51.777727Z","caller":"traceutil/trace.go:171","msg":"trace[1367009455] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"234.983038ms","start":"2026-08-14T09:08:51.542726Z","end":"2026-08-14T09:08:51.777709Z","steps":["trace[1367009455] 'process raft request' (duration: 234.849014ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:53.596357Z","caller":"traceutil/trace.go:171","msg":"trace[433108484] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"137.436286ms","start":"2026-08-14T09:08:53.458898Z","end":"2026-08-14T09:08:53.596334Z","steps":["trace[433108484] 'process raft request' (duration: 137.308263ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:53.598357Z","caller":"traceutil/trace.go:171","msg":"trace[36840143] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"137.398155ms","start":"2026-08-14T09:08:53.460929Z","end":"2026-08-14T09:08:53.598328Z","steps":["trace[36840143] 'process raft request' (duration: 137.335573ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:53.598458Z","caller":"traceutil/trace.go:171","msg":"trace[2111748367] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"139.256742ms","start":"2026-08-14T09:08:53.459186Z","end":"2026-08-14T09:08:53.598443Z","steps":["trace[2111748367] 'process raft request' (duration: 138.856212ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:08:53.598551Z","caller":"traceutil/trace.go:171","msg":"trace[1136242044] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"138.248066ms","start":"2026-08-14T09:08:53.460294Z","end":"2026-08-14T09:08:53.598542Z","steps":["trace[1136242044] 'process raft request' (duration: 137.883897ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:15.637305Z","caller":"traceutil/trace.go:171","msg":"trace[733573574] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"152.401005ms","start":"2026-08-14T09:09:15.484879Z","end":"2026-08-14T09:09:15.63728Z","steps":["trace[733573574] 'process raft request' (duration: 152.237541ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:23.824435Z","caller":"traceutil/trace.go:171","msg":"trace[1719515464] transaction","detail":"{read_only:false; response_revision:1484; number_of_response:1; }","duration":"121.614861ms","start":"2026-08-14T09:09:23.702792Z","end":"2026-08-14T09:09:23.824407Z","steps":["trace[1719515464] 'process raft request' (duration: 121.18778ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:23.97125Z","caller":"traceutil/trace.go:171","msg":"trace[1306538981] linearizableReadLoop","detail":"{readStateIndex:1549; appliedIndex:1545; }","duration":"127.194568ms","start":"2026-08-14T09:09:23.84403Z","end":"2026-08-14T09:09:23.971224Z","steps":["trace[1306538981] 'read index received' (duration: 56.059242ms)","trace[1306538981] 'applied index is now lower than readState.Index' (duration: 71.134366ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:09:23.971303Z","caller":"traceutil/trace.go:171","msg":"trace[650674865] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"137.573997ms","start":"2026-08-14T09:09:23.833705Z","end":"2026-08-14T09:09:23.971279Z","steps":["trace[650674865] 'process raft request' (duration: 137.401142ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:23.971428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.376253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:09:23.971532Z","caller":"traceutil/trace.go:171","msg":"trace[824082139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1488; }","duration":"127.487655ms","start":"2026-08-14T09:09:23.844024Z","end":"2026-08-14T09:09:23.971512Z","steps":["trace[824082139] 'agreement among raft nodes before linearized reading' (duration: 127.337662ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:23.971541Z","caller":"traceutil/trace.go:171","msg":"trace[340401050] transaction","detail":"{read_only:false; response_revision:1486; number_of_response:1; }","duration":"140.12343ms","start":"2026-08-14T09:09:23.831306Z","end":"2026-08-14T09:09:23.971429Z","steps":["trace[340401050] 'process raft request' (duration: 121.981041ms)","trace[340401050] 'compare' (duration: 17.573905ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:09:23.97145Z","caller":"traceutil/trace.go:171","msg":"trace[1246459244] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"137.622317ms","start":"2026-08-14T09:09:23.833808Z","end":"2026-08-14T09:09:23.97143Z","steps":["trace[1246459244] 'process raft request' (duration: 137.376911ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:24.295556Z","caller":"traceutil/trace.go:171","msg":"trace[2078510106] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"157.604574ms","start":"2026-08-14T09:09:24.13792Z","end":"2026-08-14T09:09:24.295524Z","steps":["trace[2078510106] 'process raft request' (duration: 157.501141ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:25.935792Z","caller":"traceutil/trace.go:171","msg":"trace[515163525] transaction","detail":"{read_only:false; response_revision:1494; number_of_response:1; }","duration":"100.981478ms","start":"2026-08-14T09:09:25.834711Z","end":"2026-08-14T09:09:25.935692Z","steps":["trace[515163525] 'process raft request' (duration: 100.779423ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:39.687803Z","caller":"traceutil/trace.go:171","msg":"trace[1225587314] linearizableReadLoop","detail":"{readStateIndex:1621; appliedIndex:1620; }","duration":"140.035988ms","start":"2026-08-14T09:09:39.547743Z","end":"2026-08-14T09:09:39.687779Z","steps":["trace[1225587314] 'read index received' (duration: 139.834963ms)","trace[1225587314] 'applied index is now lower than readState.Index' (duration: 200.055µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:09:39.687925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.170852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:09:39.687962Z","caller":"traceutil/trace.go:171","msg":"trace[163307721] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1557; }","duration":"140.260704ms","start":"2026-08-14T09:09:39.547691Z","end":"2026-08-14T09:09:39.687952Z","steps":["trace[163307721] 'agreement among raft nodes before linearized reading' (duration: 140.182772ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:39.687832Z","caller":"traceutil/trace.go:171","msg":"trace[468567419] transaction","detail":"{read_only:false; response_revision:1557; number_of_response:1; }","duration":"215.144642ms","start":"2026-08-14T09:09:39.472664Z","end":"2026-08-14T09:09:39.687808Z","steps":["trace[468567419] 'process raft request' (duration: 214.993098ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:40.340099Z","caller":"traceutil/trace.go:171","msg":"trace[231642132] linearizableReadLoop","detail":"{readStateIndex:1622; appliedIndex:1621; }","duration":"254.010487ms","start":"2026-08-14T09:09:40.086065Z","end":"2026-08-14T09:09:40.340075Z","steps":["trace[231642132] 'read index received' (duration: 253.957306ms)","trace[231642132] 'applied index is now lower than readState.Index' (duration: 51.831µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:09:40.340543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.506865ms","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-08-14T09:09:40.340645Z","caller":"traceutil/trace.go:171","msg":"trace[1503063270] transaction","detail":"{read_only:false; response_revision:1558; number_of_response:1; }","duration":"304.794959ms","start":"2026-08-14T09:09:40.035375Z","end":"2026-08-14T09:09:40.34017Z","steps":["trace[1503063270] 'process raft request' (duration: 304.543372ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:40.340762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.693785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-14T09:09:40.340697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.645505ms","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-08-14T09:09:40.341045Z","caller":"traceutil/trace.go:171","msg":"trace[1425067687] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1558; }","duration":"254.084051ms","start":"2026-08-14T09:09:40.086939Z","end":"2026-08-14T09:09:40.341023Z","steps":["trace[1425067687] 'agreement among raft nodes before linearized reading' (duration: 253.399483ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:40.341077Z","caller":"traceutil/trace.go:171","msg":"trace[1407413570] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1558; }","duration":"253.078145ms","start":"2026-08-14T09:09:40.087981Z","end":"2026-08-14T09:09:40.341059Z","steps":["trace[1407413570] 'agreement among raft nodes before linearized reading' (duration: 252.512811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:40.340622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.372222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-14T09:09:40.341321Z","caller":"traceutil/trace.go:171","msg":"trace[421430829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1558; }","duration":"252.07744ms","start":"2026-08-14T09:09:40.089211Z","end":"2026-08-14T09:09:40.341288Z","steps":["trace[421430829] 'agreement among raft nodes before linearized reading' (duration: 251.241289ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:40.340603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.487331ms","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:531"} {"level":"info","ts":"2026-08-14T09:09:40.341518Z","caller":"traceutil/trace.go:171","msg":"trace[1134786041] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1558; }","duration":"249.471755ms","start":"2026-08-14T09:09:40.092035Z","end":"2026-08-14T09:09:40.341507Z","steps":["trace[1134786041] 'agreement among raft nodes before linearized reading' (duration: 248.346527ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:40.340853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:09:40.035354Z","time spent":"305.434846ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:09:40.34089Z","caller":"traceutil/trace.go:171","msg":"trace[1631269042] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1558; }","duration":"254.809339ms","start":"2026-08-14T09:09:40.086017Z","end":"2026-08-14T09:09:40.340827Z","steps":["trace[1631269042] 'agreement among raft nodes before linearized reading' (duration: 254.171382ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:40.451061Z","caller":"traceutil/trace.go:171","msg":"trace[555438335] transaction","detail":"{read_only:false; response_revision:1560; number_of_response:1; }","duration":"104.550377ms","start":"2026-08-14T09:09:40.346483Z","end":"2026-08-14T09:09:40.451033Z","steps":["trace[555438335] 'process raft request' (duration: 101.972943ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:40.451404Z","caller":"traceutil/trace.go:171","msg":"trace[1660145969] transaction","detail":"{read_only:false; response_revision:1562; number_of_response:1; }","duration":"103.48428ms","start":"2026-08-14T09:09:40.347892Z","end":"2026-08-14T09:09:40.451376Z","steps":["trace[1660145969] 'process raft request' (duration: 103.106621ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:40.45149Z","caller":"traceutil/trace.go:171","msg":"trace[211748194] transaction","detail":"{read_only:false; response_revision:1563; number_of_response:1; }","duration":"103.366347ms","start":"2026-08-14T09:09:40.348111Z","end":"2026-08-14T09:09:40.451478Z","steps":["trace[211748194] 'process raft request' (duration: 102.929877ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:40.451738Z","caller":"traceutil/trace.go:171","msg":"trace[1919549598] transaction","detail":"{read_only:false; response_revision:1561; number_of_response:1; }","duration":"104.195218ms","start":"2026-08-14T09:09:40.347342Z","end":"2026-08-14T09:09:40.451537Z","steps":["trace[1919549598] 'process raft request' (duration: 103.591423ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:47.389664Z","caller":"traceutil/trace.go:171","msg":"trace[753657582] transaction","detail":"{read_only:false; response_revision:1592; number_of_response:1; }","duration":"225.756347ms","start":"2026-08-14T09:09:47.163882Z","end":"2026-08-14T09:09:47.389638Z","steps":["trace[753657582] 'process raft request' (duration: 225.546292ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:48.777901Z","caller":"traceutil/trace.go:171","msg":"trace[910105994] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"155.977844ms","start":"2026-08-14T09:09:48.621897Z","end":"2026-08-14T09:09:48.777875Z","steps":["trace[910105994] 'process raft request' (duration: 94.700491ms)","trace[910105994] 'compare' (duration: 61.116609ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:09:48.778362Z","caller":"traceutil/trace.go:171","msg":"trace[1358230141] transaction","detail":"{read_only:false; response_revision:1599; number_of_response:1; }","duration":"154.504157ms","start":"2026-08-14T09:09:48.6238Z","end":"2026-08-14T09:09:48.778304Z","steps":["trace[1358230141] 'process raft request' (duration: 154.035546ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:48.778559Z","caller":"traceutil/trace.go:171","msg":"trace[1710088255] linearizableReadLoop","detail":"{readStateIndex:1666; appliedIndex:1663; }","duration":"112.423083ms","start":"2026-08-14T09:09:48.6661Z","end":"2026-08-14T09:09:48.778523Z","steps":["trace[1710088255] 'read index received' (duration: 50.510095ms)","trace[1710088255] 'applied index is now lower than readState.Index' (duration: 61.911338ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:09:48.778748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.646558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:09:48.778791Z","caller":"traceutil/trace.go:171","msg":"trace[1822382530] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1600; }","duration":"112.757312ms","start":"2026-08-14T09:09:48.666023Z","end":"2026-08-14T09:09:48.77878Z","steps":["trace[1822382530] 'agreement among raft nodes before linearized reading' (duration: 112.639319ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:48.778648Z","caller":"traceutil/trace.go:171","msg":"trace[114486874] transaction","detail":"{read_only:false; response_revision:1600; number_of_response:1; }","duration":"154.729954ms","start":"2026-08-14T09:09:48.623877Z","end":"2026-08-14T09:09:48.778607Z","steps":["trace[114486874] 'process raft request' (duration: 154.319242ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:51.212895Z","caller":"traceutil/trace.go:171","msg":"trace[287601827] transaction","detail":"{read_only:false; response_revision:1610; number_of_response:1; }","duration":"347.769138ms","start":"2026-08-14T09:09:50.865109Z","end":"2026-08-14T09:09:51.212878Z","steps":["trace[287601827] 'process raft request' (duration: 347.732727ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:51.21297Z","caller":"traceutil/trace.go:171","msg":"trace[1728483167] transaction","detail":"{read_only:false; response_revision:1609; number_of_response:1; }","duration":"349.277695ms","start":"2026-08-14T09:09:50.863669Z","end":"2026-08-14T09:09:51.212947Z","steps":["trace[1728483167] 'process raft request' (duration: 349.065039ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:51.212999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:09:50.865098Z","time spent":"347.84323ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:09:51.213073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:09:50.863652Z","time spent":"349.369237ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:09:55.021538Z","caller":"traceutil/trace.go:171","msg":"trace[1631688920] linearizableReadLoop","detail":"{readStateIndex:1693; appliedIndex:1692; }","duration":"176.736819ms","start":"2026-08-14T09:09:54.844775Z","end":"2026-08-14T09:09:55.021512Z","steps":["trace[1631688920] 'read index received' (duration: 176.497513ms)","trace[1631688920] 'applied index is now lower than readState.Index' (duration: 238.096µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:09:55.021618Z","caller":"traceutil/trace.go:171","msg":"trace[1776875099] transaction","detail":"{read_only:false; response_revision:1626; number_of_response:1; }","duration":"221.592684ms","start":"2026-08-14T09:09:54.799989Z","end":"2026-08-14T09:09:55.021581Z","steps":["trace[1776875099] 'process raft request' (duration: 221.353258ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:55.021731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.933965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:09:55.021774Z","caller":"traceutil/trace.go:171","msg":"trace[1997776221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1626; }","duration":"177.001166ms","start":"2026-08-14T09:09:54.844762Z","end":"2026-08-14T09:09:55.021763Z","steps":["trace[1997776221] 'agreement among raft nodes before linearized reading' (duration: 176.905104ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:55.021919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.708934ms","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-08-14T09:09:55.022028Z","caller":"traceutil/trace.go:171","msg":"trace[95837352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1626; }","duration":"107.897309ms","start":"2026-08-14T09:09:54.914108Z","end":"2026-08-14T09:09:55.022005Z","steps":["trace[95837352] 'agreement among raft nodes before linearized reading' (duration: 107.653523ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:55.752043Z","caller":"traceutil/trace.go:171","msg":"trace[1269324758] transaction","detail":"{read_only:false; response_revision:1631; number_of_response:1; }","duration":"184.861931ms","start":"2026-08-14T09:09:55.567147Z","end":"2026-08-14T09:09:55.752009Z","steps":["trace[1269324758] 'process raft request' (duration: 145.280149ms)","trace[1269324758] 'compare' (duration: 39.273175ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:09:57.436529Z","caller":"traceutil/trace.go:171","msg":"trace[125740178] transaction","detail":"{read_only:false; response_revision:1637; number_of_response:1; }","duration":"163.49957ms","start":"2026-08-14T09:09:57.273006Z","end":"2026-08-14T09:09:57.436506Z","steps":["trace[125740178] 'process raft request' (duration: 163.162992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:57.754061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.567729ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:09:57.754431Z","caller":"traceutil/trace.go:171","msg":"trace[956854247] transaction","detail":"{read_only:false; response_revision:1638; number_of_response:1; }","duration":"226.350832ms","start":"2026-08-14T09:09:57.528032Z","end":"2026-08-14T09:09:57.754383Z","steps":["trace[956854247] 'process raft request' (duration: 104.338292ms)","trace[956854247] 'compare' (duration: 121.418535ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:10:32.216956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.068029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:10:32.217027Z","caller":"traceutil/trace.go:171","msg":"trace[1120729804] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1795; }","duration":"108.194403ms","start":"2026-08-14T09:10:32.108815Z","end":"2026-08-14T09:10:32.217009Z","steps":["trace[1120729804] 'count revisions from in-memory index tree' (duration: 107.967597ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:10:51.283754Z","caller":"traceutil/trace.go:171","msg":"trace[134842190] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"111.084874ms","start":"2026-08-14T09:10:51.172642Z","end":"2026-08-14T09:10:51.283727Z","steps":["trace[134842190] 'process raft request' (duration: 110.799357ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:11:13.41553Z","caller":"traceutil/trace.go:171","msg":"trace[759916766] linearizableReadLoop","detail":"{readStateIndex:2064; appliedIndex:2063; }","duration":"276.656632ms","start":"2026-08-14T09:11:13.138826Z","end":"2026-08-14T09:11:13.415483Z","steps":["trace[759916766] 'read index received' (duration: 203.32419ms)","trace[759916766] 'applied index is now lower than readState.Index' (duration: 73.330731ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:11:13.41582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.967579ms","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:508"} {"level":"info","ts":"2026-08-14T09:11:13.415865Z","caller":"traceutil/trace.go:171","msg":"trace[629005399] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1981; }","duration":"277.059852ms","start":"2026-08-14T09:11:13.13879Z","end":"2026-08-14T09:11:13.41585Z","steps":["trace[629005399] 'agreement among raft nodes before linearized reading' (duration: 276.832056ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:11:13.682726Z","caller":"traceutil/trace.go:171","msg":"trace[1454344764] linearizableReadLoop","detail":"{readStateIndex:2066; appliedIndex:2064; }","duration":"253.62386ms","start":"2026-08-14T09:11:13.429085Z","end":"2026-08-14T09:11:13.682709Z","steps":["trace[1454344764] 'read index received' (duration: 69.895666ms)","trace[1454344764] 'applied index is now lower than readState.Index' (duration: 183.727384ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:11:13.682868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.701153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-08-14T09:11:13.682827Z","caller":"traceutil/trace.go:171","msg":"trace[1782637366] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"262.319125ms","start":"2026-08-14T09:11:13.42048Z","end":"2026-08-14T09:11:13.6828Z","steps":["trace[1782637366] 'process raft request' (duration: 262.11605ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:11:13.682898Z","caller":"traceutil/trace.go:171","msg":"trace[1257262270] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1983; }","duration":"181.775225ms","start":"2026-08-14T09:11:13.501115Z","end":"2026-08-14T09:11:13.68289Z","steps":["trace[1257262270] 'agreement among raft nodes before linearized reading' (duration: 181.702423ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:11:13.682945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.843735ms","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-08-14T09:11:13.682978Z","caller":"traceutil/trace.go:171","msg":"trace[607184873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1983; }","duration":"253.926687ms","start":"2026-08-14T09:11:13.429042Z","end":"2026-08-14T09:11:13.682969Z","steps":["trace[607184873] 'agreement among raft nodes before linearized reading' (duration: 253.769973ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:11:13.68304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.13905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-14T09:11:13.683096Z","caller":"traceutil/trace.go:171","msg":"trace[955124391] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1983; }","duration":"142.227623ms","start":"2026-08-14T09:11:13.540855Z","end":"2026-08-14T09:11:13.683082Z","steps":["trace[955124391] 'agreement among raft nodes before linearized reading' (duration: 142.032248ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:11:13.996635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.67189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:11:13.997007Z","caller":"traceutil/trace.go:171","msg":"trace[976617100] linearizableReadLoop","detail":"{readStateIndex:2070; appliedIndex:2066; }","duration":"307.781243ms","start":"2026-08-14T09:11:13.689206Z","end":"2026-08-14T09:11:13.996988Z","steps":["trace[976617100] 'read index received' (duration: 175.732664ms)","trace[976617100] 'applied index is now lower than readState.Index' (duration: 132.047359ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:11:13.997139Z","caller":"traceutil/trace.go:171","msg":"trace[1095099787] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"308.087272ms","start":"2026-08-14T09:11:13.689034Z","end":"2026-08-14T09:11:13.997121Z","steps":["trace[1095099787] 'process raft request' (duration: 307.886187ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:11:13.997139Z","caller":"traceutil/trace.go:171","msg":"trace[1548366375] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"308.906031ms","start":"2026-08-14T09:11:13.688209Z","end":"2026-08-14T09:11:13.997115Z","steps":["trace[1548366375] 'process raft request' (duration: 308.532062ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:11:13.997136Z","caller":"traceutil/trace.go:171","msg":"trace[1805764365] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"308.745797ms","start":"2026-08-14T09:11:13.688353Z","end":"2026-08-14T09:11:13.997099Z","steps":["trace[1805764365] 'process raft request' (duration: 308.486311ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:11:13.997211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.99768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-08-14T09:11:13.997235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:13.689022Z","time spent":"308.158963ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:11:13.997241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:13.688175Z","time spent":"309.012354ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:11:13.997271Z","caller":"traceutil/trace.go:171","msg":"trace[374054456] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1987; }","duration":"308.05222ms","start":"2026-08-14T09:11:13.689184Z","end":"2026-08-14T09:11:13.997237Z","steps":["trace[374054456] 'agreement among raft nodes before linearized reading' (duration: 307.949668ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:11:13.997315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:13.68897Z","time spent":"308.334607ms","remote":"127.0.0.1:60578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-08-14T09:11:13.997335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:13.688321Z","time spent":"308.897881ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:11:13.997384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.173765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:11:13.997527Z","caller":"traceutil/trace.go:171","msg":"trace[1349588974] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1987; }","duration":"155.40496ms","start":"2026-08-14T09:11:13.842094Z","end":"2026-08-14T09:11:13.997499Z","steps":["trace[1349588974] 'agreement among raft nodes before linearized reading' (duration: 155.139763ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:11:13.997547Z","caller":"traceutil/trace.go:171","msg":"trace[2088627457] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"309.857995ms","start":"2026-08-14T09:11:13.687661Z","end":"2026-08-14T09:11:13.997519Z","steps":["trace[2088627457] 'process raft request' (duration: 177.216542ms)","trace[2088627457] 'compare' (duration: 131.536356ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:11:13.997617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:13.687646Z","time spent":"309.938058ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:11:14.255538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.46079ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:11:14.255663Z","caller":"traceutil/trace.go:171","msg":"trace[1562596043] linearizableReadLoop","detail":"{readStateIndex:2071; appliedIndex:2070; }","duration":"128.989794ms","start":"2026-08-14T09:11:14.126652Z","end":"2026-08-14T09:11:14.255641Z","steps":["trace[1562596043] 'read index received' (duration: 27.274238ms)","trace[1562596043] 'applied index is now lower than readState.Index' (duration: 101.713836ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:11:14.255784Z","caller":"traceutil/trace.go:171","msg":"trace[337522825] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"252.0324ms","start":"2026-08-14T09:11:14.003689Z","end":"2026-08-14T09:11:14.255721Z","steps":["trace[337522825] 'process raft request' (duration: 150.286373ms)","trace[337522825] 'compare' (duration: 101.273985ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:11:14.255823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.169008ms","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-08-14T09:11:14.255979Z","caller":"traceutil/trace.go:171","msg":"trace[637527030] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1988; }","duration":"129.349263ms","start":"2026-08-14T09:11:14.1266Z","end":"2026-08-14T09:11:14.25595Z","steps":["trace[637527030] 'agreement among raft nodes before linearized reading' (duration: 129.099606ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:11:53.92067Z","caller":"traceutil/trace.go:171","msg":"trace[564120639] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"123.037825ms","start":"2026-08-14T09:11:53.797587Z","end":"2026-08-14T09:11:53.920625Z","steps":["trace[564120639] 'process raft request' (duration: 122.688697ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:12:00.221074Z","caller":"traceutil/trace.go:171","msg":"trace[552183569] linearizableReadLoop","detail":"{readStateIndex:2315; appliedIndex:2314; }","duration":"376.479589ms","start":"2026-08-14T09:11:59.844563Z","end":"2026-08-14T09:12:00.221042Z","steps":["trace[552183569] 'read index received' (duration: 376.268894ms)","trace[552183569] 'applied index is now lower than readState.Index' (duration: 209.065µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:12:00.221178Z","caller":"traceutil/trace.go:171","msg":"trace[835596088] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"486.05582ms","start":"2026-08-14T09:11:59.735066Z","end":"2026-08-14T09:12:00.221122Z","steps":["trace[835596088] 'process raft request' (duration: 485.798904ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:12:00.221269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.257696ms","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-08-14T09:12:00.221296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:59.735028Z","time spent":"486.202674ms","remote":"127.0.0.1:60576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:12:00.221311Z","caller":"traceutil/trace.go:171","msg":"trace[79742025] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2222; }","duration":"211.361079ms","start":"2026-08-14T09:12:00.009938Z","end":"2026-08-14T09:12:00.2213Z","steps":["trace[79742025] 'agreement among raft nodes before linearized reading' (duration: 211.278357ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:12:00.221951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.741975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:12:00.221984Z","caller":"traceutil/trace.go:171","msg":"trace[2139394611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2222; }","duration":"377.479295ms","start":"2026-08-14T09:11:59.844495Z","end":"2026-08-14T09:12:00.221974Z","steps":["trace[2139394611] 'agreement among raft nodes before linearized reading' (duration: 376.719016ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:12:00.222009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:11:59.844472Z","time spent":"377.530046ms","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T09:12:00.426263Z","caller":"traceutil/trace.go:171","msg":"trace[2105323341] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"175.791615ms","start":"2026-08-14T09:12:00.250433Z","end":"2026-08-14T09:12:00.426224Z","steps":["trace[2105323341] 'process raft request' (duration: 175.623021ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:12:00.426304Z","caller":"traceutil/trace.go:171","msg":"trace[933586666] linearizableReadLoop","detail":"{readStateIndex:2316; appliedIndex:2316; }","duration":"135.253399ms","start":"2026-08-14T09:12:00.291016Z","end":"2026-08-14T09:12:00.426269Z","steps":["trace[933586666] 'read index received' (duration: 135.243158ms)","trace[933586666] 'applied index is now lower than readState.Index' (duration: 7.591µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:12:00.426738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.497031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-14T09:12:00.426569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.511286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:12:00.426932Z","caller":"traceutil/trace.go:171","msg":"trace[1996381671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2223; }","duration":"132.705357ms","start":"2026-08-14T09:12:00.294213Z","end":"2026-08-14T09:12:00.426919Z","steps":["trace[1996381671] 'agreement among raft nodes before linearized reading' (duration: 132.376509ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:12:00.426954Z","caller":"traceutil/trace.go:171","msg":"trace[1440803474] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2223; }","duration":"135.968037ms","start":"2026-08-14T09:12:00.290971Z","end":"2026-08-14T09:12:00.426939Z","steps":["trace[1440803474] 'agreement among raft nodes before linearized reading' (duration: 135.439294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:12:00.426933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.904921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-14T09:12:00.427134Z","caller":"traceutil/trace.go:171","msg":"trace[842204702] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2223; }","duration":"133.118316ms","start":"2026-08-14T09:12:00.293997Z","end":"2026-08-14T09:12:00.427115Z","steps":["trace[842204702] 'agreement among raft nodes before linearized reading' (duration: 132.486011ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:12:10.686479Z","caller":"traceutil/trace.go:171","msg":"trace[899069686] linearizableReadLoop","detail":"{readStateIndex:2374; appliedIndex:2373; }","duration":"100.385603ms","start":"2026-08-14T09:12:10.586051Z","end":"2026-08-14T09:12:10.686437Z","steps":["trace[899069686] 'read index received' (duration: 63.575159ms)","trace[899069686] 'applied index is now lower than readState.Index' (duration: 36.808544ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:12:10.68658Z","caller":"traceutil/trace.go:171","msg":"trace[379787252] transaction","detail":"{read_only:false; response_revision:2279; number_of_response:1; }","duration":"101.614423ms","start":"2026-08-14T09:12:10.584922Z","end":"2026-08-14T09:12:10.686537Z","steps":["trace[379787252] 'process raft request' (duration: 64.754188ms)","trace[379787252] 'compare' (duration: 36.568738ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:12:10.686846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.762762ms","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-08-14T09:12:10.686931Z","caller":"traceutil/trace.go:171","msg":"trace[1702531440] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2279; }","duration":"100.887276ms","start":"2026-08-14T09:12:10.586022Z","end":"2026-08-14T09:12:10.686909Z","steps":["trace[1702531440] 'agreement among raft nodes before linearized reading' (duration: 100.618259ms)"],"step_count":1}