{"level":"warn","ts":"2026-06-04T11:59:00.239111Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-04T11:59:00.239351Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-06-04T11:59:00.239516Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-04T11:59:00.239584Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-06-04T11:59:00.239651Z","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-06-04T11:59:00.240941Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-06-04T11:59:00.241139Z","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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-06-04T11:59:00.244013Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.457977ms"} {"level":"info","ts":"2026-06-04T11:59:00.250534Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-06-04T11:59:00.250627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-06-04T11:59:00.25066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-06-04T11:59:00.250685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-04T11:59:00.250702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-06-04T11:59:00.25075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-06-04T11:59:00.255754Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-04T11:59:00.258245Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-04T11:59:00.259607Z","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-06-04T11:59:00.261729Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-04T11:59:00.263537Z","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-06-04T11:59:00.264348Z","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-06-04T11:59:00.264373Z","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-06-04T11:59:00.264326Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-04T11:59:00.267492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-06-04T11:59:00.267677Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-06-04T11:59:00.268281Z","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-06-04T11:59:00.268391Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-06-04T11:59:00.268454Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-06-04T11:59:00.268614Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-04T11:59:00.268702Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-04T11:59:00.651782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-06-04T11:59:00.651858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-04T11:59:00.651895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-06-04T11:59:00.651917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-06-04T11:59:00.651928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-06-04T11:59:00.651944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-06-04T11:59:00.651958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-06-04T11:59:00.653639Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-06-04T11:59:00.654022Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T11:59:00.654899Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-04T11:59:00.654949Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-04T11:59:00.655193Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T11:59:00.65541Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T11:59:00.655524Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T11:59:00.656343Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-04T11:59:00.656429Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-04T11:59:00.656547Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-06-04T11:59:00.658163Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-04T11:59:24.073414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:23.654444Z","time spent":"418.963808ms","remote":"127.0.0.1:37696","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-04T11:59:24.073401Z","caller":"traceutil/trace.go:171","msg":"trace[1268582630] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:439; }","duration":"170.568772ms","start":"2026-06-04T11:59:23.9028Z","end":"2026-06-04T11:59:24.073369Z","steps":["trace[1268582630] 'read index received' (duration: 170.442429ms)","trace[1268582630] 'applied index is now lower than readState.Index' (duration: 124.483µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T11:59:24.073585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.766717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-04T11:59:24.07372Z","caller":"traceutil/trace.go:171","msg":"trace[1997286008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:427; }","duration":"170.938262ms","start":"2026-06-04T11:59:23.902749Z","end":"2026-06-04T11:59:24.073687Z","steps":["trace[1997286008] 'agreement among raft nodes before linearized reading' (duration: 170.746937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:24.073737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.156652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"} {"level":"info","ts":"2026-06-04T11:59:24.073809Z","caller":"traceutil/trace.go:171","msg":"trace[1327652083] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:427; }","duration":"132.241834ms","start":"2026-06-04T11:59:23.941548Z","end":"2026-06-04T11:59:24.07379Z","steps":["trace[1327652083] 'agreement among raft nodes before linearized reading' (duration: 132.08031ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T11:59:33.378009Z","caller":"traceutil/trace.go:171","msg":"trace[2113891651] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"378.144155ms","start":"2026-06-04T11:59:32.999845Z","end":"2026-06-04T11:59:33.37799Z","steps":["trace[2113891651] 'process raft request' (duration: 378.035532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:33.378561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:32.999836Z","time spent":"378.301808ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T11:59:38.413728Z","caller":"traceutil/trace.go:171","msg":"trace[539278103] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"220.239838ms","start":"2026-06-04T11:59:38.193447Z","end":"2026-06-04T11:59:38.413687Z","steps":["trace[539278103] 'process raft request' (duration: 220.036683ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T11:59:38.741108Z","caller":"traceutil/trace.go:171","msg":"trace[573304098] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"534.282702ms","start":"2026-06-04T11:59:38.206553Z","end":"2026-06-04T11:59:38.740836Z","steps":["trace[573304098] 'process raft request' (duration: 533.831282ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T11:59:38.741371Z","caller":"traceutil/trace.go:171","msg":"trace[92918661] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"535.833476ms","start":"2026-06-04T11:59:38.204663Z","end":"2026-06-04T11:59:38.740496Z","steps":["trace[92918661] 'process raft request' (duration: 535.510579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:38.741326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.206546Z","time spent":"534.66748ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T11:59:38.741525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.204644Z","time spent":"536.805229ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T11:59:38.743178Z","caller":"traceutil/trace.go:171","msg":"trace[496305385] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"515.743431ms","start":"2026-06-04T11:59:38.227308Z","end":"2026-06-04T11:59:38.743052Z","steps":["trace[496305385] 'process raft request' (duration: 513.733686ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T11:59:38.743166Z","caller":"traceutil/trace.go:171","msg":"trace[1908624363] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"522.082275ms","start":"2026-06-04T11:59:38.218528Z","end":"2026-06-04T11:59:38.740611Z","steps":["trace[1908624363] 'process raft request' (duration: 521.918421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:38.743377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.227264Z","time spent":"515.988257ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T11:59:38.74334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.218521Z","time spent":"524.747506ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T11:59:38.743993Z","caller":"traceutil/trace.go:171","msg":"trace[775037644] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"514.232179ms","start":"2026-06-04T11:59:38.229321Z","end":"2026-06-04T11:59:38.743553Z","steps":["trace[775037644] 'process raft request' (duration: 512.861767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:38.744193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.229298Z","time spent":"514.78472ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T11:59:38.745993Z","caller":"traceutil/trace.go:171","msg":"trace[1004615036] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"516.589502ms","start":"2026-06-04T11:59:38.229386Z","end":"2026-06-04T11:59:38.745976Z","steps":["trace[1004615036] 'process raft request' (duration: 516.07993ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T11:59:38.746043Z","caller":"traceutil/trace.go:171","msg":"trace[1408454495] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"510.728139ms","start":"2026-06-04T11:59:38.2353Z","end":"2026-06-04T11:59:38.746028Z","steps":["trace[1408454495] 'process raft request' (duration: 510.502414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:38.746073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.229383Z","time spent":"516.653033ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T11:59:38.746103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.235286Z","time spent":"510.792211ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T11:59:38.746196Z","caller":"traceutil/trace.go:171","msg":"trace[249262501] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"493.13253ms","start":"2026-06-04T11:59:38.253045Z","end":"2026-06-04T11:59:38.746177Z","steps":["trace[249262501] 'process raft request' (duration: 492.872674ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T11:59:38.746211Z","caller":"traceutil/trace.go:171","msg":"trace[518706423] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"516.050668ms","start":"2026-06-04T11:59:38.230143Z","end":"2026-06-04T11:59:38.746194Z","steps":["trace[518706423] 'process raft request' (duration: 515.534117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:38.746353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.253027Z","time spent":"493.276723ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T11:59:38.746415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.230137Z","time spent":"516.252703ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T11:59:38.746586Z","caller":"traceutil/trace.go:171","msg":"trace[1417740545] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"485.012386ms","start":"2026-06-04T11:59:38.26156Z","end":"2026-06-04T11:59:38.746572Z","steps":["trace[1417740545] 'process raft request' (duration: 484.580836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:38.746653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.261525Z","time spent":"485.096528ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T11:59:38.74719Z","caller":"traceutil/trace.go:171","msg":"trace[2053272597] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"372.229741ms","start":"2026-06-04T11:59:38.374945Z","end":"2026-06-04T11:59:38.747175Z","steps":["trace[2053272597] 'process raft request' (duration: 371.831772ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T11:59:38.755664Z","caller":"traceutil/trace.go:171","msg":"trace[821126761] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"327.385496ms","start":"2026-06-04T11:59:38.424395Z","end":"2026-06-04T11:59:38.751781Z","steps":["trace[821126761] 'process raft request' (duration: 327.275893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:38.755738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.424368Z","time spent":"331.336944ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T11:59:38.752097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.374901Z","time spent":"377.130473ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T11:59:38.755943Z","caller":"traceutil/trace.go:171","msg":"trace[1493870196] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"329.165945ms","start":"2026-06-04T11:59:38.426767Z","end":"2026-06-04T11:59:38.755933Z","steps":["trace[1493870196] 'process raft request' (duration: 324.980181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:38.756032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.426739Z","time spent":"329.258267ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T11:59:38.747316Z","caller":"traceutil/trace.go:171","msg":"trace[616319768] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:539; }","duration":"522.403473ms","start":"2026-06-04T11:59:38.224695Z","end":"2026-06-04T11:59:38.747098Z","steps":["trace[616319768] 'read index received' (duration: 188.765616ms)","trace[616319768] 'applied index is now lower than readState.Index' (duration: 333.636697ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T11:59:38.747476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.769061ms","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-06-04T11:59:38.761325Z","caller":"traceutil/trace.go:171","msg":"trace[2024636310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:535; }","duration":"536.645984ms","start":"2026-06-04T11:59:38.224664Z","end":"2026-06-04T11:59:38.76131Z","steps":["trace[2024636310] 'agreement among raft nodes before linearized reading' (duration: 522.655557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:38.76138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.22465Z","time spent":"536.710856ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-04T11:59:38.764459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.270162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-04T11:59:38.764635Z","caller":"traceutil/trace.go:171","msg":"trace[1212843547] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:542; }","duration":"387.367814ms","start":"2026-06-04T11:59:38.377135Z","end":"2026-06-04T11:59:38.764503Z","steps":["trace[1212843547] 'agreement among raft nodes before linearized reading' (duration: 387.249911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:38.764666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:38.377123Z","time spent":"387.536117ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-04T11:59:45.117085Z","caller":"traceutil/trace.go:171","msg":"trace[1535669427] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"307.811353ms","start":"2026-06-04T11:59:44.809236Z","end":"2026-06-04T11:59:45.117048Z","steps":["trace[1535669427] 'read index received' (duration: 306.513214ms)","trace[1535669427] 'applied index is now lower than readState.Index' (duration: 1.296939ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T11:59:45.117211Z","caller":"traceutil/trace.go:171","msg":"trace[995641230] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"397.678287ms","start":"2026-06-04T11:59:44.719492Z","end":"2026-06-04T11:59:45.11717Z","steps":["trace[995641230] 'process raft request' (duration: 396.759637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:45.117381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.044428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-04T11:59:45.117428Z","caller":"traceutil/trace.go:171","msg":"trace[987257135] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"308.222441ms","start":"2026-06-04T11:59:44.809193Z","end":"2026-06-04T11:59:45.117416Z","steps":["trace[987257135] 'agreement among raft nodes before linearized reading' (duration: 308.028646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:45.117466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:44.809173Z","time spent":"308.285183ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-04T11:59:45.117481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:44.719468Z","time spent":"397.878592ms","remote":"127.0.0.1:37752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T11:59:45.117884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.481631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-04T11:59:45.118012Z","caller":"traceutil/trace.go:171","msg":"trace[487078804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"306.634985ms","start":"2026-06-04T11:59:44.811353Z","end":"2026-06-04T11:59:45.117988Z","steps":["trace[487078804] 'agreement among raft nodes before linearized reading' (duration: 306.203115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:45.117928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.041155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-04T11:59:45.118101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:44.811323Z","time spent":"306.764208ms","remote":"127.0.0.1:37940","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-06-04T11:59:45.118249Z","caller":"traceutil/trace.go:171","msg":"trace[1073933740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"160.319481ms","start":"2026-06-04T11:59:44.957822Z","end":"2026-06-04T11:59:45.118142Z","steps":["trace[1073933740] 'agreement among raft nodes before linearized reading' (duration: 159.998244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:45.685161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.533689ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T11:59:45.685396Z","caller":"traceutil/trace.go:171","msg":"trace[822810079] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:642; }","duration":"239.608677ms","start":"2026-06-04T11:59:45.44577Z","end":"2026-06-04T11:59:45.685379Z","steps":["trace[822810079] 'read index received' (duration: 88.472754ms)","trace[822810079] 'applied index is now lower than readState.Index' (duration: 151.135023ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T11:59:45.685604Z","caller":"traceutil/trace.go:171","msg":"trace[497616207] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"563.143396ms","start":"2026-06-04T11:59:45.122448Z","end":"2026-06-04T11:59:45.685591Z","steps":["trace[497616207] 'process raft request' (duration: 298.951162ms)","trace[497616207] 'compare' (duration: 263.08803ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T11:59:45.685662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:45.122427Z","time spent":"563.203598ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T11:59:45.685904Z","caller":"traceutil/trace.go:171","msg":"trace[1585231102] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"562.688876ms","start":"2026-06-04T11:59:45.123206Z","end":"2026-06-04T11:59:45.685895Z","steps":["trace[1585231102] 'process raft request' (duration: 562.055022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:45.685953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:45.123179Z","time spent":"562.748048ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T11:59:45.686023Z","caller":"traceutil/trace.go:171","msg":"trace[1377294149] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"561.874797ms","start":"2026-06-04T11:59:45.124141Z","end":"2026-06-04T11:59:45.686016Z","steps":["trace[1377294149] 'process raft request' (duration: 561.168591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:45.686062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:45.124118Z","time spent":"561.921948ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T11:59:45.686194Z","caller":"traceutil/trace.go:171","msg":"trace[2051400758] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"514.034143ms","start":"2026-06-04T11:59:45.172149Z","end":"2026-06-04T11:59:45.686183Z","steps":["trace[2051400758] 'process raft request' (duration: 513.190555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:45.686239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:45.172109Z","time spent":"514.108325ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T11:59:45.686346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.57968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vt77x\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-04T11:59:45.686373Z","caller":"traceutil/trace.go:171","msg":"trace[340101854] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vt77x; range_end:; response_count:1; response_revision:624; }","duration":"240.62707ms","start":"2026-06-04T11:59:45.445736Z","end":"2026-06-04T11:59:45.686363Z","steps":["trace[340101854] 'agreement among raft nodes before linearized reading' (duration: 240.568459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:45.686944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.537121ms","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-06-04T11:59:45.687019Z","caller":"traceutil/trace.go:171","msg":"trace[1599785763] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"188.663205ms","start":"2026-06-04T11:59:45.498336Z","end":"2026-06-04T11:59:45.686999Z","steps":["trace[1599785763] 'agreement among raft nodes before linearized reading' (duration: 188.474699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:46.096018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.013514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T11:59:46.096133Z","caller":"traceutil/trace.go:171","msg":"trace[1732389084] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"399.876087ms","start":"2026-06-04T11:59:45.696238Z","end":"2026-06-04T11:59:46.096114Z","steps":["trace[1732389084] 'read index received' (duration: 133.678307ms)","trace[1732389084] 'applied index is now lower than readState.Index' (duration: 266.1962ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T11:59:46.096356Z","caller":"traceutil/trace.go:171","msg":"trace[1830181499] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"402.812114ms","start":"2026-06-04T11:59:45.693531Z","end":"2026-06-04T11:59:46.096343Z","steps":["trace[1830181499] 'process raft request' (duration: 136.369439ms)","trace[1830181499] 'compare' (duration: 265.850501ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T11:59:46.096429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:45.6935Z","time spent":"402.894516ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T11:59:46.096522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.253726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T11:59:46.09662Z","caller":"traceutil/trace.go:171","msg":"trace[801408227] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:625; }","duration":"400.401159ms","start":"2026-06-04T11:59:45.696198Z","end":"2026-06-04T11:59:46.096599Z","steps":["trace[801408227] 'agreement among raft nodes before linearized reading' (duration: 400.235305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:46.096682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:45.696177Z","time spent":"400.496001ms","remote":"127.0.0.1:37998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":27,"request content":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-06-04T11:59:46.124045Z","caller":"traceutil/trace.go:171","msg":"trace[1233935406] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"418.652994ms","start":"2026-06-04T11:59:45.705377Z","end":"2026-06-04T11:59:46.12403Z","steps":["trace[1233935406] 'process raft request' (duration: 418.52453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:46.124151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:45.705363Z","time spent":"418.731895ms","remote":"127.0.0.1:37864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T11:59:46.150811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.269482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T11:59:46.150926Z","caller":"traceutil/trace.go:171","msg":"trace[704249818] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"157.395955ms","start":"2026-06-04T11:59:45.993474Z","end":"2026-06-04T11:59:46.15087Z","steps":["trace[704249818] 'agreement among raft nodes before linearized reading' (duration: 157.261362ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T11:59:46.150899Z","caller":"traceutil/trace.go:171","msg":"trace[1282285180] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"307.187829ms","start":"2026-06-04T11:59:45.843643Z","end":"2026-06-04T11:59:46.15083Z","steps":["trace[1282285180] 'process raft request' (duration: 306.976274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:46.151079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:45.843612Z","time spent":"307.377173ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T11:59:47.57012Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843859846864778,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T11:59:47.63245Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.100750413s","expected-duration":"1s"} {"level":"info","ts":"2026-06-04T11:59:47.637923Z","caller":"traceutil/trace.go:171","msg":"trace[235456618] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"567.948395ms","start":"2026-06-04T11:59:47.069954Z","end":"2026-06-04T11:59:47.637902Z","steps":["trace[235456618] 'read index received' (duration: 562.683966ms)","trace[235456618] 'applied index is now lower than readState.Index' (duration: 5.263479ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T11:59:47.638011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.046997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T11:59:47.638042Z","caller":"traceutil/trace.go:171","msg":"trace[470984022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"568.130759ms","start":"2026-06-04T11:59:47.069899Z","end":"2026-06-04T11:59:47.63803Z","steps":["trace[470984022] 'agreement among raft nodes before linearized reading' (duration: 568.063048ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T11:59:47.638047Z","caller":"traceutil/trace.go:171","msg":"trace[1697042753] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.107745451s","start":"2026-06-04T11:59:46.530269Z","end":"2026-06-04T11:59:47.638014Z","steps":["trace[1697042753] 'process raft request' (duration: 1.102638315s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:47.638074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:47.069879Z","time spent":"568.18764ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-04T11:59:47.638178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:46.530223Z","time spent":"1.107879774s","remote":"127.0.0.1:37752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036165,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T11:59:48.955812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.074605ms","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-06-04T11:59:48.955937Z","caller":"traceutil/trace.go:171","msg":"trace[566380821] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:639; }","duration":"126.213048ms","start":"2026-06-04T11:59:48.829702Z","end":"2026-06-04T11:59:48.955915Z","steps":["trace[566380821] 'range keys from in-memory index tree' (duration: 126.027404ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T11:59:48.95921Z","caller":"traceutil/trace.go:171","msg":"trace[1623002849] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"355.165964ms","start":"2026-06-04T11:59:48.604031Z","end":"2026-06-04T11:59:48.959197Z","steps":["trace[1623002849] 'process raft request' (duration: 354.736264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T11:59:48.959304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T11:59:48.604001Z","time spent":"355.249597ms","remote":"127.0.0.1:37752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036237,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:00:03.901979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.354948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-04T12:00:03.902025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.770035ms","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-06-04T12:00:03.902075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.938712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-04T12:00:03.902094Z","caller":"traceutil/trace.go:171","msg":"trace[1929361338] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:799; }","duration":"245.524001ms","start":"2026-06-04T12:00:03.656545Z","end":"2026-06-04T12:00:03.902069Z","steps":["trace[1929361338] 'range keys from in-memory index tree' (duration: 245.152743ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:00:03.902107Z","caller":"traceutil/trace.go:171","msg":"trace[412709391] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:799; }","duration":"131.887298ms","start":"2026-06-04T12:00:03.7702Z","end":"2026-06-04T12:00:03.902087Z","steps":["trace[412709391] 'range keys from in-memory index tree' (duration: 131.586361ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:00:03.902147Z","caller":"traceutil/trace.go:171","msg":"trace[1967220210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:799; }","duration":"133.045495ms","start":"2026-06-04T12:00:03.769081Z","end":"2026-06-04T12:00:03.902127Z","steps":["trace[1967220210] 'range keys from in-memory index tree' (duration: 132.743037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:00:03.902414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.29042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-04T12:00:03.902445Z","caller":"traceutil/trace.go:171","msg":"trace[178275618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:799; }","duration":"133.34351ms","start":"2026-06-04T12:00:03.769092Z","end":"2026-06-04T12:00:03.902435Z","steps":["trace[178275618] 'range keys from in-memory index tree' (duration: 133.188338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:00:03.902508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.630553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-04T12:00:03.902556Z","caller":"traceutil/trace.go:171","msg":"trace[1421908341] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:799; }","duration":"652.734825ms","start":"2026-06-04T12:00:03.249807Z","end":"2026-06-04T12:00:03.902542Z","steps":["trace[1421908341] 'range keys from in-memory index tree' (duration: 652.451509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:00:03.902584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.910355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7sp9d\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-06-04T12:00:03.902597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:00:03.249778Z","time spent":"652.806137ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-04T12:00:03.902616Z","caller":"traceutil/trace.go:171","msg":"trace[1603910538] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7sp9d; range_end:; response_count:1; response_revision:799; }","duration":"342.584709ms","start":"2026-06-04T12:00:03.560021Z","end":"2026-06-04T12:00:03.902606Z","steps":["trace[1603910538] 'range keys from in-memory index tree' (duration: 341.752151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:00:03.902645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:00:03.560002Z","time spent":"342.634831ms","remote":"127.0.0.1:37864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7sp9d\" "} {"level":"warn","ts":"2026-06-04T12:00:03.90279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.368749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:00:03.902816Z","caller":"traceutil/trace.go:171","msg":"trace[2016400658] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:799; }","duration":"551.442661ms","start":"2026-06-04T12:00:03.351365Z","end":"2026-06-04T12:00:03.902808Z","steps":["trace[2016400658] 'count revisions from in-memory index tree' (duration: 551.286708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:00:03.902842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:00:03.351343Z","time spent":"551.491332ms","remote":"127.0.0.1:37962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-04T12:00:04.107077Z","caller":"traceutil/trace.go:171","msg":"trace[2008754640] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"199.823636ms","start":"2026-06-04T12:00:03.907228Z","end":"2026-06-04T12:00:04.107052Z","steps":["trace[2008754640] 'process raft request' (duration: 199.608811ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:00:04.107306Z","caller":"traceutil/trace.go:171","msg":"trace[420277273] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"199.5915ms","start":"2026-06-04T12:00:03.907695Z","end":"2026-06-04T12:00:04.107286Z","steps":["trace[420277273] 'process raft request' (duration: 199.309364ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:00:04.107568Z","caller":"traceutil/trace.go:171","msg":"trace[205254186] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"199.606831ms","start":"2026-06-04T12:00:03.907941Z","end":"2026-06-04T12:00:04.107547Z","steps":["trace[205254186] 'process raft request' (duration: 199.284454ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:00:04.107653Z","caller":"traceutil/trace.go:171","msg":"trace[360408984] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"199.373346ms","start":"2026-06-04T12:00:03.908268Z","end":"2026-06-04T12:00:04.107641Z","steps":["trace[360408984] 'process raft request' (duration: 199.197442ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:00:04.10769Z","caller":"traceutil/trace.go:171","msg":"trace[1603897086] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"197.439052ms","start":"2026-06-04T12:00:03.910234Z","end":"2026-06-04T12:00:04.107673Z","steps":["trace[1603897086] 'process raft request' (duration: 197.308839ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:00:38.573417Z","caller":"traceutil/trace.go:171","msg":"trace[755095724] linearizableReadLoop","detail":"{readStateIndex:1054; appliedIndex:1053; }","duration":"285.431568ms","start":"2026-06-04T12:00:38.287966Z","end":"2026-06-04T12:00:38.573397Z","steps":["trace[755095724] 'read index received' (duration: 285.299585ms)","trace[755095724] 'applied index is now lower than readState.Index' (duration: 130.883µs)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:00:38.573492Z","caller":"traceutil/trace.go:171","msg":"trace[955409870] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"286.864241ms","start":"2026-06-04T12:00:38.286595Z","end":"2026-06-04T12:00:38.57346Z","steps":["trace[955409870] 'process raft request' (duration: 286.643036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:00:38.573659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.667604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-04T12:00:38.573703Z","caller":"traceutil/trace.go:171","msg":"trace[688808679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1017; }","duration":"285.737605ms","start":"2026-06-04T12:00:38.28795Z","end":"2026-06-04T12:00:38.573688Z","steps":["trace[688808679] 'agreement among raft nodes before linearized reading' (duration: 285.583832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:00:38.573782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.597424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-04T12:00:38.573823Z","caller":"traceutil/trace.go:171","msg":"trace[1570294996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1017; }","duration":"263.683986ms","start":"2026-06-04T12:00:38.310129Z","end":"2026-06-04T12:00:38.573813Z","steps":["trace[1570294996] 'agreement among raft nodes before linearized reading' (duration: 263.537733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:00:38.573953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.058857ms","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-06-04T12:00:38.573983Z","caller":"traceutil/trace.go:171","msg":"trace[1814963599] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1017; }","duration":"262.101218ms","start":"2026-06-04T12:00:38.311875Z","end":"2026-06-04T12:00:38.573976Z","steps":["trace[1814963599] 'agreement among raft nodes before linearized reading' (duration: 262.020266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:00:38.573965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.880913ms","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-06-04T12:00:38.574037Z","caller":"traceutil/trace.go:171","msg":"trace[1122106796] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1017; }","duration":"258.993995ms","start":"2026-06-04T12:00:38.315025Z","end":"2026-06-04T12:00:38.574019Z","steps":["trace[1122106796] 'agreement among raft nodes before linearized reading' (duration: 258.80134ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:00:38.678433Z","caller":"traceutil/trace.go:171","msg":"trace[39747611] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"100.352292ms","start":"2026-06-04T12:00:38.578058Z","end":"2026-06-04T12:00:38.67841Z","steps":["trace[39747611] 'process raft request' (duration: 100.295071ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:00:38.678443Z","caller":"traceutil/trace.go:171","msg":"trace[1002890442] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"100.395423ms","start":"2026-06-04T12:00:38.578005Z","end":"2026-06-04T12:00:38.678401Z","steps":["trace[1002890442] 'process raft request' (duration: 84.369085ms)","trace[1002890442] 'compare' (duration: 15.872755ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:00:40.21652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.440286ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-04T12:00:40.216934Z","caller":"traceutil/trace.go:171","msg":"trace[670140899] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"1.234414493s","start":"2026-06-04T12:00:38.982503Z","end":"2026-06-04T12:00:40.216917Z","steps":["trace[670140899] 'process raft request' (duration: 1.234102386s)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:00:40.216958Z","caller":"traceutil/trace.go:171","msg":"trace[1873440796] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1058; }","duration":"1.22539942s","start":"2026-06-04T12:00:38.991513Z","end":"2026-06-04T12:00:40.216913Z","steps":["trace[1873440796] 'read index received' (duration: 428.666669ms)","trace[1873440796] 'applied index is now lower than readState.Index' (duration: 796.729981ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:00:40.217038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:00:38.982485Z","time spent":"1.234485904s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:00:40.25637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.264842539s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:00:40.256439Z","caller":"traceutil/trace.go:171","msg":"trace[1071465090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1022; }","duration":"1.264934471s","start":"2026-06-04T12:00:38.991485Z","end":"2026-06-04T12:00:40.25642Z","steps":["trace[1071465090] 'agreement among raft nodes before linearized reading' (duration: 1.225507783s)","trace[1071465090] 'range keys from in-memory index tree' (duration: 39.315355ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:00:40.256481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:00:38.991477Z","time spent":"1.264996312s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-04T12:00:40.25673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"931.388469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:00:40.256859Z","caller":"traceutil/trace.go:171","msg":"trace[1907855561] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1022; }","duration":"931.592475ms","start":"2026-06-04T12:00:39.325233Z","end":"2026-06-04T12:00:40.256826Z","steps":["trace[1907855561] 'agreement among raft nodes before linearized reading' (duration: 891.893591ms)","trace[1907855561] 'count revisions from in-memory index tree' (duration: 39.466659ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:00:40.256922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:00:39.325212Z","time spent":"931.697437ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-06-04T12:01:03.508484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.878231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:03.508555Z","caller":"traceutil/trace.go:171","msg":"trace[2040754421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1094; }","duration":"516.019704ms","start":"2026-06-04T12:01:02.992517Z","end":"2026-06-04T12:01:03.508537Z","steps":["trace[2040754421] 'range keys from in-memory index tree' (duration: 515.726358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:03.508593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:02.992483Z","time spent":"516.101706ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-04T12:01:03.508821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.765176ms","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-06-04T12:01:03.508737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.707457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-04T12:01:03.508963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.7042ms","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-06-04T12:01:03.508996Z","caller":"traceutil/trace.go:171","msg":"trace[1714172064] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1094; }","duration":"790.77581ms","start":"2026-06-04T12:01:02.718212Z","end":"2026-06-04T12:01:03.508988Z","steps":["trace[1714172064] 'range keys from in-memory index tree' (duration: 790.602897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:03.50903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:02.718191Z","time spent":"790.829872ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T12:01:03.509029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.439754ms","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-06-04T12:01:03.509081Z","caller":"traceutil/trace.go:171","msg":"trace[663103894] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1094; }","duration":"725.510745ms","start":"2026-06-04T12:01:02.783553Z","end":"2026-06-04T12:01:03.509064Z","steps":["trace[663103894] 'range keys from in-memory index tree' (duration: 725.31195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:03.509143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:02.783542Z","time spent":"725.589407ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-04T12:01:03.508879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.292207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:03.509236Z","caller":"traceutil/trace.go:171","msg":"trace[1262675674] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1094; }","duration":"402.709558ms","start":"2026-06-04T12:01:03.106514Z","end":"2026-06-04T12:01:03.509224Z","steps":["trace[1262675674] 'count revisions from in-memory index tree' (duration: 402.196445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:03.509273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:03.106489Z","time spent":"402.77127ms","remote":"127.0.0.1:38062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-06-04T12:01:03.508881Z","caller":"traceutil/trace.go:171","msg":"trace[1867739650] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1094; }","duration":"718.843697ms","start":"2026-06-04T12:01:02.79002Z","end":"2026-06-04T12:01:03.508864Z","steps":["trace[1867739650] 'range keys from in-memory index tree' (duration: 718.670424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:03.509358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:02.790012Z","time spent":"719.33359ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-04T12:01:03.509391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.061515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:03.509463Z","caller":"traceutil/trace.go:171","msg":"trace[479147419] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1094; }","duration":"742.195598ms","start":"2026-06-04T12:01:02.767252Z","end":"2026-06-04T12:01:03.509448Z","steps":["trace[479147419] 'count revisions from in-memory index tree' (duration: 741.988733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:03.509501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:02.767233Z","time spent":"742.258659ms","remote":"127.0.0.1:35438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-04T12:01:03.509209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.954686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-04T12:01:03.509002Z","caller":"traceutil/trace.go:171","msg":"trace[1108535557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1094; }","duration":"827.015684ms","start":"2026-06-04T12:01:02.681972Z","end":"2026-06-04T12:01:03.508987Z","steps":["trace[1108535557] 'range keys from in-memory index tree' (duration: 826.477212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:03.509697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:02.681955Z","time spent":"827.723611ms","remote":"127.0.0.1:37940","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-06-04T12:01:03.509659Z","caller":"traceutil/trace.go:171","msg":"trace[1151499064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1094; }","duration":"723.444737ms","start":"2026-06-04T12:01:02.786192Z","end":"2026-06-04T12:01:03.509637Z","steps":["trace[1151499064] 'range keys from in-memory index tree' (duration: 722.673538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:03.509879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:02.786184Z","time spent":"723.677533ms","remote":"127.0.0.1:37940","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-06-04T12:01:03.740846Z","caller":"traceutil/trace.go:171","msg":"trace[1065614102] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"225.046696ms","start":"2026-06-04T12:01:03.515755Z","end":"2026-06-04T12:01:03.740801Z","steps":["trace[1065614102] 'process raft request' (duration: 224.859362ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:03.741269Z","caller":"traceutil/trace.go:171","msg":"trace[1456794391] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"225.528388ms","start":"2026-06-04T12:01:03.515722Z","end":"2026-06-04T12:01:03.74125Z","steps":["trace[1456794391] 'process raft request' (duration: 224.862552ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:03.741442Z","caller":"traceutil/trace.go:171","msg":"trace[1302394600] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"225.774963ms","start":"2026-06-04T12:01:03.515655Z","end":"2026-06-04T12:01:03.74143Z","steps":["trace[1302394600] 'process raft request' (duration: 224.882052ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:03.742044Z","caller":"traceutil/trace.go:171","msg":"trace[1306930095] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"225.499057ms","start":"2026-06-04T12:01:03.515638Z","end":"2026-06-04T12:01:03.741137Z","steps":["trace[1306930095] 'process raft request' (duration: 212.683406ms)","trace[1306930095] 'compare' (duration: 12.096074ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:06.103847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.997303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:06.103944Z","caller":"traceutil/trace.go:171","msg":"trace[13299044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1107; }","duration":"111.150356ms","start":"2026-06-04T12:01:05.992775Z","end":"2026-06-04T12:01:06.103925Z","steps":["trace[13299044] 'range keys from in-memory index tree' (duration: 110.913761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:24.188324Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843859846866075,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T12:01:24.688959Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843859846866075,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T12:01:25.001172Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.339092676s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-04T12:01:25.001431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:23.661971Z","time spent":"1.339457145s","remote":"127.0.0.1:37696","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-04T12:01:25.188529Z","caller":"traceutil/trace.go:171","msg":"trace[339882253] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"186.362656ms","start":"2026-06-04T12:01:25.002135Z","end":"2026-06-04T12:01:25.188497Z","steps":["trace[339882253] 'process raft request' (duration: 186.271193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:25.189512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.501423066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:25.190168Z","caller":"traceutil/trace.go:171","msg":"trace[2062712203] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1213; }","duration":"1.502133873s","start":"2026-06-04T12:01:23.688006Z","end":"2026-06-04T12:01:25.19014Z","steps":["trace[2062712203] 'agreement among raft nodes before linearized reading' (duration: 1.501338354s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:25.190354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:23.687982Z","time spent":"1.502334297s","remote":"127.0.0.1:49676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-04T12:01:25.189167Z","caller":"traceutil/trace.go:171","msg":"trace[1636370349] linearizableReadLoop","detail":"{readStateIndex:1261; appliedIndex:1260; }","duration":"1.501093608s","start":"2026-06-04T12:01:23.68803Z","end":"2026-06-04T12:01:25.189123Z","steps":["trace[1636370349] 'read index received' (duration: 1.313614566s)","trace[1636370349] 'applied index is now lower than readState.Index' (duration: 187.475202ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:25.191854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.340597841s","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-06-04T12:01:25.191928Z","caller":"traceutil/trace.go:171","msg":"trace[1128067526] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1213; }","duration":"1.340738735s","start":"2026-06-04T12:01:23.851171Z","end":"2026-06-04T12:01:25.19191Z","steps":["trace[1128067526] 'agreement among raft nodes before linearized reading' (duration: 1.340449307s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:25.191987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:23.851153Z","time spent":"1.340816236s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T12:01:25.192306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.327235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-04T12:01:25.192359Z","caller":"traceutil/trace.go:171","msg":"trace[974715189] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1213; }","duration":"101.420838ms","start":"2026-06-04T12:01:25.090924Z","end":"2026-06-04T12:01:25.192345Z","steps":["trace[974715189] 'agreement among raft nodes before linearized reading' (duration: 101.328416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:25.192577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.643328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:25.192626Z","caller":"traceutil/trace.go:171","msg":"trace[1960160337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1213; }","duration":"199.72005ms","start":"2026-06-04T12:01:24.992893Z","end":"2026-06-04T12:01:25.192613Z","steps":["trace[1960160337] 'agreement among raft nodes before linearized reading' (duration: 199.645338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:25.19282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.711638ms","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-06-04T12:01:25.192867Z","caller":"traceutil/trace.go:171","msg":"trace[297591997] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1213; }","duration":"662.786849ms","start":"2026-06-04T12:01:24.530069Z","end":"2026-06-04T12:01:25.192856Z","steps":["trace[297591997] 'agreement among raft nodes before linearized reading' (duration: 662.718777ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:25.1929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:24.530041Z","time spent":"662.84898ms","remote":"127.0.0.1:49742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-04T12:01:25.193095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.159150491s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:25.193141Z","caller":"traceutil/trace.go:171","msg":"trace[1513149894] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1213; }","duration":"1.159239273s","start":"2026-06-04T12:01:24.03389Z","end":"2026-06-04T12:01:25.193129Z","steps":["trace[1513149894] 'agreement among raft nodes before linearized reading' (duration: 1.159172411s)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:25.194424Z","caller":"traceutil/trace.go:171","msg":"trace[472624294] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"745.632829ms","start":"2026-06-04T12:01:24.44299Z","end":"2026-06-04T12:01:25.188623Z","steps":["trace[472624294] 'process raft request' (duration: 734.148468ms)","trace[472624294] 'compare' (duration: 11.085391ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:25.194597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:24.442978Z","time spent":"751.513986ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:01:25.196323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.314445226s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-04T12:01:25.196427Z","caller":"traceutil/trace.go:171","msg":"trace[487254828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1213; }","duration":"1.314556958s","start":"2026-06-04T12:01:23.881854Z","end":"2026-06-04T12:01:25.196411Z","steps":["trace[487254828] 'agreement among raft nodes before linearized reading' (duration: 1.314284882s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:25.196467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:23.881851Z","time spent":"1.3146023s","remote":"127.0.0.1:37940","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-06-04T12:01:25.195435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.313567036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-04T12:01:25.196786Z","caller":"traceutil/trace.go:171","msg":"trace[1200165598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1213; }","duration":"1.314934077s","start":"2026-06-04T12:01:23.881834Z","end":"2026-06-04T12:01:25.196769Z","steps":["trace[1200165598] 'agreement among raft nodes before linearized reading' (duration: 1.313446973s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:25.196825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:23.88183Z","time spent":"1.314986828s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-04T12:01:25.196839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.335217624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-04T12:01:25.196883Z","caller":"traceutil/trace.go:171","msg":"trace[1974637639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1213; }","duration":"1.335275965s","start":"2026-06-04T12:01:23.861593Z","end":"2026-06-04T12:01:25.196869Z","steps":["trace[1974637639] 'agreement among raft nodes before linearized reading' (duration: 1.334559118s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:25.196922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:23.861584Z","time spent":"1.335332856s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-04T12:01:25.197316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.341859561s","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-06-04T12:01:25.197407Z","caller":"traceutil/trace.go:171","msg":"trace[1684853989] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1213; }","duration":"1.341969054s","start":"2026-06-04T12:01:23.855422Z","end":"2026-06-04T12:01:25.197391Z","steps":["trace[1684853989] 'agreement among raft nodes before linearized reading' (duration: 1.339584937s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:25.197449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:23.855413Z","time spent":"1.342025965s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-04T12:01:25.201618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:24.033854Z","time spent":"1.159346116s","remote":"127.0.0.1:59856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-06-04T12:01:43.586181Z","caller":"traceutil/trace.go:171","msg":"trace[4258742] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1350; }","duration":"249.170978ms","start":"2026-06-04T12:01:43.336985Z","end":"2026-06-04T12:01:43.586156Z","steps":["trace[4258742] 'read index received' (duration: 248.899402ms)","trace[4258742] 'applied index is now lower than readState.Index' (duration: 269.966µs)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:01:43.586313Z","caller":"traceutil/trace.go:171","msg":"trace[385794039] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"327.099145ms","start":"2026-06-04T12:01:43.259202Z","end":"2026-06-04T12:01:43.586301Z","steps":["trace[385794039] 'process raft request' (duration: 326.772307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:43.586444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:43.259183Z","time spent":"327.158035ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:01:43.586634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.176351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-04T12:01:43.586697Z","caller":"traceutil/trace.go:171","msg":"trace[909724906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1299; }","duration":"246.274262ms","start":"2026-06-04T12:01:43.340409Z","end":"2026-06-04T12:01:43.586683Z","steps":["trace[909724906] 'agreement among raft nodes before linearized reading' (duration: 246.113998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:43.586756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.890078ms","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-06-04T12:01:43.586835Z","caller":"traceutil/trace.go:171","msg":"trace[392291676] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1299; }","duration":"218.98137ms","start":"2026-06-04T12:01:43.367823Z","end":"2026-06-04T12:01:43.586804Z","steps":["trace[392291676] 'agreement among raft nodes before linearized reading' (duration: 218.742694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:43.586932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.418016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-04T12:01:43.586956Z","caller":"traceutil/trace.go:171","msg":"trace[2122515051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1299; }","duration":"225.455418ms","start":"2026-06-04T12:01:43.361494Z","end":"2026-06-04T12:01:43.586949Z","steps":["trace[2122515051] 'agreement among raft nodes before linearized reading' (duration: 225.364636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:43.587015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.983296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-04T12:01:43.587074Z","caller":"traceutil/trace.go:171","msg":"trace[1502611440] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1299; }","duration":"250.113749ms","start":"2026-06-04T12:01:43.336945Z","end":"2026-06-04T12:01:43.587059Z","steps":["trace[1502611440] 'agreement among raft nodes before linearized reading' (duration: 249.852694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:43.587096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.717324ms","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-06-04T12:01:43.587115Z","caller":"traceutil/trace.go:171","msg":"trace[1038235626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1299; }","duration":"225.735705ms","start":"2026-06-04T12:01:43.361374Z","end":"2026-06-04T12:01:43.587109Z","steps":["trace[1038235626] 'agreement among raft nodes before linearized reading' (duration: 225.685233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:44.781325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.399157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T12:01:44.781759Z","caller":"traceutil/trace.go:171","msg":"trace[1320622219] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"1.191138284s","start":"2026-06-04T12:01:43.590596Z","end":"2026-06-04T12:01:44.781734Z","steps":["trace[1320622219] 'process raft request' (duration: 1.19098198s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:44.781955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:43.590577Z","time spent":"1.191320909s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T12:01:44.781946Z","caller":"traceutil/trace.go:171","msg":"trace[166696221] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"1.191230597s","start":"2026-06-04T12:01:43.590573Z","end":"2026-06-04T12:01:44.781803Z","steps":["trace[166696221] 'process raft request' (duration: 483.911228ms)","trace[166696221] 'compare' (duration: 704.032683ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:44.782488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:43.590554Z","time spent":"1.191687207s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:01:45.362575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.819641ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T12:01:45.362923Z","caller":"traceutil/trace.go:171","msg":"trace[2096153851] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"1.771839448s","start":"2026-06-04T12:01:43.59105Z","end":"2026-06-04T12:01:45.36289Z","steps":["trace[2096153851] 'process raft request' (duration: 1.291994373s)","trace[2096153851] 'compare' (duration: 477.149393ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:45.363073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:43.591036Z","time spent":"1.77194942s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T12:01:45.364435Z","caller":"traceutil/trace.go:171","msg":"trace[677238000] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"1.76976347s","start":"2026-06-04T12:01:43.594511Z","end":"2026-06-04T12:01:45.364274Z","steps":["trace[677238000] 'process raft request' (duration: 1.768540772s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:45.364937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:43.594501Z","time spent":"1.770375944s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T12:01:45.365853Z","caller":"traceutil/trace.go:171","msg":"trace[1722129896] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"1.770534017s","start":"2026-06-04T12:01:43.595286Z","end":"2026-06-04T12:01:45.36582Z","steps":["trace[1722129896] 'process raft request' (duration: 1.770129798s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:45.365959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.707978892s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-04T12:01:45.365992Z","caller":"traceutil/trace.go:171","msg":"trace[216209980] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1304; }","duration":"1.708016403s","start":"2026-06-04T12:01:43.657966Z","end":"2026-06-04T12:01:45.365983Z","steps":["trace[216209980] 'agreement among raft nodes before linearized reading' (duration: 1.707951752s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:45.366029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:43.657915Z","time spent":"1.708099265s","remote":"127.0.0.1:37856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":29,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-06-04T12:01:45.366077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:43.595272Z","time spent":"1.77065403s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T12:01:45.365733Z","caller":"traceutil/trace.go:171","msg":"trace[3609164] linearizableReadLoop","detail":"{readStateIndex:1356; appliedIndex:1351; }","duration":"1.707739497s","start":"2026-06-04T12:01:43.657982Z","end":"2026-06-04T12:01:45.365722Z","steps":["trace[3609164] 'read index received' (duration: 416.500502ms)","trace[3609164] 'applied index is now lower than readState.Index' (duration: 1.291237785s)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:45.368915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.377210904s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:45.368951Z","caller":"traceutil/trace.go:171","msg":"trace[1501991775] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1304; }","duration":"1.377282116s","start":"2026-06-04T12:01:43.99166Z","end":"2026-06-04T12:01:45.368942Z","steps":["trace[1501991775] 'agreement among raft nodes before linearized reading' (duration: 1.377222485s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:45.368974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:43.991638Z","time spent":"1.377330887s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-04T12:01:45.369442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.706716522s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-04T12:01:45.36948Z","caller":"traceutil/trace.go:171","msg":"trace[1932915825] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:1304; }","duration":"1.706788404s","start":"2026-06-04T12:01:43.662681Z","end":"2026-06-04T12:01:45.369469Z","steps":["trace[1932915825] 'agreement among raft nodes before linearized reading' (duration: 1.706629991s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:45.369501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:43.662662Z","time spent":"1.706834606s","remote":"127.0.0.1:37696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.205\" "} {"level":"warn","ts":"2026-06-04T12:01:45.747384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.375623ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T12:01:45.747634Z","caller":"traceutil/trace.go:171","msg":"trace[808841679] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"154.91897ms","start":"2026-06-04T12:01:45.59269Z","end":"2026-06-04T12:01:45.747609Z","steps":["trace[808841679] 'process raft request' (duration: 154.830118ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:45.747877Z","caller":"traceutil/trace.go:171","msg":"trace[1209080164] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"292.493605ms","start":"2026-06-04T12:01:45.455322Z","end":"2026-06-04T12:01:45.747815Z","steps":["trace[1209080164] 'process raft request' (duration: 178.559969ms)","trace[1209080164] 'compare' (duration: 113.103397ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:47.28708Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843859846866282,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-04T12:01:47.293451Z","caller":"traceutil/trace.go:171","msg":"trace[1439216768] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1360; }","duration":"506.712147ms","start":"2026-06-04T12:01:46.7867Z","end":"2026-06-04T12:01:47.293412Z","steps":["trace[1439216768] 'read index received' (duration: 506.545214ms)","trace[1439216768] 'applied index is now lower than readState.Index' (duration: 165.173µs)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:01:47.293549Z","caller":"traceutil/trace.go:171","msg":"trace[592689607] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"653.952421ms","start":"2026-06-04T12:01:46.639561Z","end":"2026-06-04T12:01:47.293514Z","steps":["trace[592689607] 'process raft request' (duration: 653.590622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:47.293703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.904904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:47.293742Z","caller":"traceutil/trace.go:171","msg":"trace[1363564653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1308; }","duration":"299.989537ms","start":"2026-06-04T12:01:46.993743Z","end":"2026-06-04T12:01:47.293733Z","steps":["trace[1363564653] 'agreement among raft nodes before linearized reading' (duration: 299.924985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:47.293722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:46.639546Z","time spent":"654.093684ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:01:47.29376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:46.993716Z","time spent":"300.040197ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-04T12:01:47.293836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.012551ms","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-06-04T12:01:47.29397Z","caller":"traceutil/trace.go:171","msg":"trace[1150607589] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1308; }","duration":"506.208175ms","start":"2026-06-04T12:01:46.787746Z","end":"2026-06-04T12:01:47.293954Z","steps":["trace[1150607589] 'agreement among raft nodes before linearized reading' (duration: 505.893237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:47.294032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:46.78773Z","time spent":"506.285827ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T12:01:47.294086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.403412ms","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-06-04T12:01:47.294114Z","caller":"traceutil/trace.go:171","msg":"trace[259034501] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1308; }","duration":"507.491695ms","start":"2026-06-04T12:01:46.786616Z","end":"2026-06-04T12:01:47.294108Z","steps":["trace[259034501] 'agreement among raft nodes before linearized reading' (duration: 506.971183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:47.294131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:46.786583Z","time spent":"507.545216ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-04T12:01:47.870552Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646843859846866286,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-04T12:01:47.886069Z","caller":"traceutil/trace.go:171","msg":"trace[893155090] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"587.189412ms","start":"2026-06-04T12:01:47.298857Z","end":"2026-06-04T12:01:47.886046Z","steps":["trace[893155090] 'process raft request' (duration: 584.235735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:47.88619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:47.298844Z","time spent":"587.287804ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T12:01:47.90388Z","caller":"traceutil/trace.go:171","msg":"trace[994096258] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1361; }","duration":"534.109792ms","start":"2026-06-04T12:01:47.369756Z","end":"2026-06-04T12:01:47.903866Z","steps":["trace[994096258] 'read index received' (duration: 513.329319ms)","trace[994096258] 'applied index is now lower than readState.Index' (duration: 20.779263ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:01:47.904246Z","caller":"traceutil/trace.go:171","msg":"trace[1830859241] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"604.765222ms","start":"2026-06-04T12:01:47.299455Z","end":"2026-06-04T12:01:47.904221Z","steps":["trace[1830859241] 'process raft request' (duration: 604.319202ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:47.904339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:47.299437Z","time spent":"604.850564ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:01:47.904385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.19361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-04T12:01:47.904422Z","caller":"traceutil/trace.go:171","msg":"trace[837143705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1311; }","duration":"533.286233ms","start":"2026-06-04T12:01:47.371124Z","end":"2026-06-04T12:01:47.90441Z","steps":["trace[837143705] 'agreement among raft nodes before linearized reading' (duration: 533.13648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:47.904407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.620544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-04T12:01:47.90452Z","caller":"traceutil/trace.go:171","msg":"trace[1257497665] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1311; }","duration":"534.827568ms","start":"2026-06-04T12:01:47.369664Z","end":"2026-06-04T12:01:47.904491Z","steps":["trace[1257497665] 'agreement among raft nodes before linearized reading' (duration: 534.447749ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:47.904587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:47.369625Z","time spent":"534.945921ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-04T12:01:47.904451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:47.371091Z","time spent":"533.352524ms","remote":"127.0.0.1:37940","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-06-04T12:01:47.904611Z","caller":"traceutil/trace.go:171","msg":"trace[1220607124] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"149.048626ms","start":"2026-06-04T12:01:47.755468Z","end":"2026-06-04T12:01:47.904517Z","steps":["trace[1220607124] 'process raft request' (duration: 148.367871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:47.904407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.209331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-04T12:01:47.904779Z","caller":"traceutil/trace.go:171","msg":"trace[675820075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1311; }","duration":"533.640101ms","start":"2026-06-04T12:01:47.371123Z","end":"2026-06-04T12:01:47.904763Z","steps":["trace[675820075] 'agreement among raft nodes before linearized reading' (duration: 533.101379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:47.904925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:47.371108Z","time spent":"533.803384ms","remote":"127.0.0.1:37940","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-06-04T12:01:48.097547Z","caller":"traceutil/trace.go:171","msg":"trace[512512851] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"186.985302ms","start":"2026-06-04T12:01:47.910537Z","end":"2026-06-04T12:01:48.097522Z","steps":["trace[512512851] 'process raft request' (duration: 186.89507ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:48.097843Z","caller":"traceutil/trace.go:171","msg":"trace[2087405251] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"187.83382ms","start":"2026-06-04T12:01:47.909764Z","end":"2026-06-04T12:01:48.097598Z","steps":["trace[2087405251] 'process raft request' (duration: 126.773499ms)","trace[2087405251] 'compare' (duration: 60.733544ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:01:48.097926Z","caller":"traceutil/trace.go:171","msg":"trace[803502140] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1365; }","duration":"101.83189ms","start":"2026-06-04T12:01:47.996064Z","end":"2026-06-04T12:01:48.097895Z","steps":["trace[803502140] 'read index received' (duration: 40.293098ms)","trace[803502140] 'applied index is now lower than readState.Index' (duration: 61.536752ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:01:48.098017Z","caller":"traceutil/trace.go:171","msg":"trace[1393125462] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"173.981904ms","start":"2026-06-04T12:01:47.924014Z","end":"2026-06-04T12:01:48.097996Z","steps":["trace[1393125462] 'process raft request' (duration: 173.459323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:48.098065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.976423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:48.098102Z","caller":"traceutil/trace.go:171","msg":"trace[1820142440] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1315; }","duration":"102.089385ms","start":"2026-06-04T12:01:47.996001Z","end":"2026-06-04T12:01:48.098091Z","steps":["trace[1820142440] 'agreement among raft nodes before linearized reading' (duration: 101.993193ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:48.528749Z","caller":"traceutil/trace.go:171","msg":"trace[1046707449] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1369; }","duration":"189.53677ms","start":"2026-06-04T12:01:48.339186Z","end":"2026-06-04T12:01:48.528723Z","steps":["trace[1046707449] 'read index received' (duration: 100.112133ms)","trace[1046707449] 'applied index is now lower than readState.Index' (duration: 89.422477ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:01:48.528771Z","caller":"traceutil/trace.go:171","msg":"trace[360905015] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"191.521724ms","start":"2026-06-04T12:01:48.337207Z","end":"2026-06-04T12:01:48.528728Z","steps":["trace[360905015] 'process raft request' (duration: 102.078406ms)","trace[360905015] 'compare' (duration: 89.110501ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:48.529015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.808686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:48.529505Z","caller":"traceutil/trace.go:171","msg":"trace[1151949048] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1317; }","duration":"190.340388ms","start":"2026-06-04T12:01:48.339139Z","end":"2026-06-04T12:01:48.52948Z","steps":["trace[1151949048] 'agreement among raft nodes before linearized reading' (duration: 189.659823ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:49.738547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.289208ms","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-06-04T12:01:49.738915Z","caller":"traceutil/trace.go:171","msg":"trace[581236568] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1319; }","duration":"908.624676ms","start":"2026-06-04T12:01:48.830219Z","end":"2026-06-04T12:01:49.738843Z","steps":["trace[581236568] 'range keys from in-memory index tree' (duration: 908.248618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:49.739481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.803321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-04T12:01:49.739703Z","caller":"traceutil/trace.go:171","msg":"trace[206116884] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"1.156168086s","start":"2026-06-04T12:01:48.583494Z","end":"2026-06-04T12:01:49.739662Z","steps":["trace[206116884] 'process raft request' (duration: 347.112589ms)","trace[206116884] 'compare' (duration: 808.628068ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:01:49.73984Z","caller":"traceutil/trace.go:171","msg":"trace[1491472758] linearizableReadLoop","detail":"{readStateIndex:1373; appliedIndex:1372; }","duration":"1.15545555s","start":"2026-06-04T12:01:48.584368Z","end":"2026-06-04T12:01:49.739824Z","steps":["trace[1491472758] 'read index received' (duration: 346.198288ms)","trace[1491472758] 'applied index is now lower than readState.Index' (duration: 809.255452ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:49.739849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:48.58347Z","time spent":"1.156309269s","remote":"127.0.0.1:37740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":869,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-04T12:01:49.740003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155627954s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-04T12:01:49.740024Z","caller":"traceutil/trace.go:171","msg":"trace[2092907940] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1321; }","duration":"1.155708376s","start":"2026-06-04T12:01:48.584308Z","end":"2026-06-04T12:01:49.740017Z","steps":["trace[2092907940] 'agreement among raft nodes before linearized reading' (duration: 1.155609674s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:49.740059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:48.584284Z","time spent":"1.155769297s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-04T12:01:49.740235Z","caller":"traceutil/trace.go:171","msg":"trace[238489935] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"980.77216ms","start":"2026-06-04T12:01:48.759446Z","end":"2026-06-04T12:01:49.740218Z","steps":["trace[238489935] 'process raft request' (duration: 980.127135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:49.740334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:48.75941Z","time spent":"980.871783ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:01:49.765032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.241467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:49.765096Z","caller":"traceutil/trace.go:171","msg":"trace[1254240377] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1321; }","duration":"614.345809ms","start":"2026-06-04T12:01:49.150732Z","end":"2026-06-04T12:01:49.765078Z","steps":["trace[1254240377] 'agreement among raft nodes before linearized reading' (duration: 614.220216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:49.765152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:49.150712Z","time spent":"614.432012ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-04T12:01:49.765041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.900813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:49.765291Z","caller":"traceutil/trace.go:171","msg":"trace[1546564243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1321; }","duration":"773.20024ms","start":"2026-06-04T12:01:48.992067Z","end":"2026-06-04T12:01:49.765267Z","steps":["trace[1546564243] 'agreement among raft nodes before linearized reading' (duration: 772.874512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:49.765368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:48.992046Z","time spent":"773.308582ms","remote":"127.0.0.1:37658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-04T12:01:50.069894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.044092ms","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-06-04T12:01:50.070001Z","caller":"traceutil/trace.go:171","msg":"trace[344946604] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1322; }","duration":"180.228206ms","start":"2026-06-04T12:01:49.889738Z","end":"2026-06-04T12:01:50.069966Z","steps":["trace[344946604] 'range keys from in-memory index tree' (duration: 179.804567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:50.070086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.887846ms","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-06-04T12:01:50.070193Z","caller":"traceutil/trace.go:171","msg":"trace[1997167957] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1322; }","duration":"161.032089ms","start":"2026-06-04T12:01:49.909136Z","end":"2026-06-04T12:01:50.070168Z","steps":["trace[1997167957] 'range keys from in-memory index tree' (duration: 160.704602ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:50.10774Z","caller":"traceutil/trace.go:171","msg":"trace[938716524] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"197.789877ms","start":"2026-06-04T12:01:49.909927Z","end":"2026-06-04T12:01:50.107717Z","steps":["trace[938716524] 'process raft request' (duration: 197.188193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:50.108161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.413606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-04T12:01:50.108232Z","caller":"traceutil/trace.go:171","msg":"trace[1476244873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1323; }","duration":"171.550628ms","start":"2026-06-04T12:01:49.936665Z","end":"2026-06-04T12:01:50.108216Z","steps":["trace[1476244873] 'agreement among raft nodes before linearized reading' (duration: 171.135889ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:50.107736Z","caller":"traceutil/trace.go:171","msg":"trace[18783801] linearizableReadLoop","detail":"{readStateIndex:1377; appliedIndex:1376; }","duration":"170.950525ms","start":"2026-06-04T12:01:49.936725Z","end":"2026-06-04T12:01:50.107676Z","steps":["trace[18783801] 'read index received' (duration: 170.252849ms)","trace[18783801] 'applied index is now lower than readState.Index' (duration: 696.146µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:50.114667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.463305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T12:01:50.114717Z","caller":"traceutil/trace.go:171","msg":"trace[2138061082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1325; }","duration":"120.572948ms","start":"2026-06-04T12:01:49.994132Z","end":"2026-06-04T12:01:50.114705Z","steps":["trace[2138061082] 'agreement among raft nodes before linearized reading' (duration: 120.462655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:56.146686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.90842524s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T12:01:56.146769Z","caller":"traceutil/trace.go:171","msg":"trace[129023290] linearizableReadLoop","detail":"{readStateIndex:1423; appliedIndex:1422; }","duration":"1.373703755s","start":"2026-06-04T12:01:54.773051Z","end":"2026-06-04T12:01:56.146755Z","steps":["trace[129023290] 'read index received' (duration: 63.872µs)","trace[129023290] 'applied index is now lower than readState.Index' (duration: 1.373638363s)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:01:56.146976Z","caller":"traceutil/trace.go:171","msg":"trace[1840501781] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"1.96239019s","start":"2026-06-04T12:01:54.184571Z","end":"2026-06-04T12:01:56.146962Z","steps":["trace[1840501781] 'process raft request' (duration: 53.619922ms)","trace[1840501781] 'compare' (duration: 1.907699964s)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:01:56.147047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:54.184497Z","time spent":"1.962508443s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:01:56.147242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.374192906s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-04T12:01:56.147271Z","caller":"traceutil/trace.go:171","msg":"trace[1797915072] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1368; }","duration":"1.374264248s","start":"2026-06-04T12:01:54.772997Z","end":"2026-06-04T12:01:56.147262Z","steps":["trace[1797915072] 'agreement among raft nodes before linearized reading' (duration: 1.374165566s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:56.147294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:54.77297Z","time spent":"1.37431843s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-04T12:01:56.474723Z","caller":"traceutil/trace.go:171","msg":"trace[1924084944] linearizableReadLoop","detail":"{readStateIndex:1425; appliedIndex:1423; }","duration":"327.906803ms","start":"2026-06-04T12:01:56.146792Z","end":"2026-06-04T12:01:56.474699Z","steps":["trace[1924084944] 'read index received' (duration: 323.673836ms)","trace[1924084944] 'applied index is now lower than readState.Index' (duration: 4.231897ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:01:56.475505Z","caller":"traceutil/trace.go:171","msg":"trace[1887321571] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"324.246869ms","start":"2026-06-04T12:01:56.150509Z","end":"2026-06-04T12:01:56.474756Z","steps":["trace[1887321571] 'process raft request' (duration: 324.143896ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:56.475631Z","caller":"traceutil/trace.go:171","msg":"trace[1348911147] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"569.583581ms","start":"2026-06-04T12:01:55.906026Z","end":"2026-06-04T12:01:56.47561Z","steps":["trace[1348911147] 'process raft request' (duration: 564.409023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:56.475708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.796146ms","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-06-04T12:01:56.475742Z","caller":"traceutil/trace.go:171","msg":"trace[413323050] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1371; }","duration":"329.844367ms","start":"2026-06-04T12:01:56.145888Z","end":"2026-06-04T12:01:56.475733Z","steps":["trace[413323050] 'agreement among raft nodes before linearized reading' (duration: 329.778465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:56.475751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:55.906001Z","time spent":"569.684763ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:01:56.475776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:56.145879Z","time spent":"329.885358ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-04T12:01:56.475644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.683033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-04T12:01:56.475846Z","caller":"traceutil/trace.go:171","msg":"trace[1561053347] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1371; }","duration":"329.914798ms","start":"2026-06-04T12:01:56.145925Z","end":"2026-06-04T12:01:56.47584Z","steps":["trace[1561053347] 'agreement among raft nodes before linearized reading' (duration: 328.916746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:56.475872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:56.145921Z","time spent":"329.945369ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T12:01:56.476037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.608177ms","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-06-04T12:01:56.476062Z","caller":"traceutil/trace.go:171","msg":"trace[418654951] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1371; }","duration":"338.672378ms","start":"2026-06-04T12:01:56.137384Z","end":"2026-06-04T12:01:56.476057Z","steps":["trace[418654951] 'agreement among raft nodes before linearized reading' (duration: 338.548165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:56.475817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.48317682s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-04T12:01:56.47613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.175209082s","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:532"} {"level":"info","ts":"2026-06-04T12:01:56.476151Z","caller":"traceutil/trace.go:171","msg":"trace[1290052542] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1371; }","duration":"1.175278353s","start":"2026-06-04T12:01:55.300867Z","end":"2026-06-04T12:01:56.476146Z","steps":["trace[1290052542] 'agreement among raft nodes before linearized reading' (duration: 1.175232272s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:56.476165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:55.300836Z","time spent":"1.175325454s","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-04T12:01:56.476073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:56.137371Z","time spent":"338.700358ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-04T12:01:56.476152Z","caller":"traceutil/trace.go:171","msg":"trace[2098093866] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1371; }","duration":"1.483571359s","start":"2026-06-04T12:01:54.992555Z","end":"2026-06-04T12:01:56.476127Z","steps":["trace[2098093866] 'agreement among raft nodes before linearized reading' (duration: 1.483130669s)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:56.476222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:54.992529Z","time spent":"1.483685402s","remote":"127.0.0.1:37658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-04T12:01:56.47622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.726677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-04T12:01:56.475871Z","caller":"traceutil/trace.go:171","msg":"trace[996463417] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"345.76011ms","start":"2026-06-04T12:01:56.130102Z","end":"2026-06-04T12:01:56.475863Z","steps":["trace[996463417] 'process raft request' (duration: 344.444299ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:01:56.476412Z","caller":"traceutil/trace.go:171","msg":"trace[2087671343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1371; }","duration":"270.095884ms","start":"2026-06-04T12:01:56.20629Z","end":"2026-06-04T12:01:56.476386Z","steps":["trace[2087671343] 'agreement among raft nodes before linearized reading' (duration: 269.478201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:01:56.476457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:56.13008Z","time spent":"346.328633ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T12:01:56.477094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T12:01:56.150494Z","time spent":"325.219571ms","remote":"127.0.0.1:37940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T12:02:02.690539Z","caller":"traceutil/trace.go:171","msg":"trace[1359766721] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"174.695241ms","start":"2026-06-04T12:02:02.515823Z","end":"2026-06-04T12:02:02.690518Z","steps":["trace[1359766721] 'process raft request' (duration: 174.663651ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:02:02.69055Z","caller":"traceutil/trace.go:171","msg":"trace[1396026930] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"178.602569ms","start":"2026-06-04T12:02:02.511916Z","end":"2026-06-04T12:02:02.690519Z","steps":["trace[1396026930] 'process raft request' (duration: 111.841589ms)","trace[1396026930] 'compare' (duration: 66.480504ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:02:02.690709Z","caller":"traceutil/trace.go:171","msg":"trace[641713264] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"178.686391ms","start":"2026-06-04T12:02:02.512015Z","end":"2026-06-04T12:02:02.690702Z","steps":["trace[641713264] 'process raft request' (duration: 178.372084ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:02:02.69077Z","caller":"traceutil/trace.go:171","msg":"trace[608470598] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"176.308868ms","start":"2026-06-04T12:02:02.51444Z","end":"2026-06-04T12:02:02.690749Z","steps":["trace[608470598] 'process raft request' (duration: 176.016612ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:02:02.69076Z","caller":"traceutil/trace.go:171","msg":"trace[1488751268] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"178.518858ms","start":"2026-06-04T12:02:02.512203Z","end":"2026-06-04T12:02:02.690722Z","steps":["trace[1488751268] 'process raft request' (duration: 178.222391ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:05:47.287616Z","caller":"traceutil/trace.go:171","msg":"trace[1456966172] transaction","detail":"{read_only:false; response_revision:2450; number_of_response:1; }","duration":"290.760294ms","start":"2026-06-04T12:05:46.996823Z","end":"2026-06-04T12:05:47.287583Z","steps":["trace[1456966172] 'process raft request' (duration: 290.607741ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:05:47.425282Z","caller":"traceutil/trace.go:171","msg":"trace[2134899763] transaction","detail":"{read_only:false; response_revision:2451; number_of_response:1; }","duration":"133.32844ms","start":"2026-06-04T12:05:47.291918Z","end":"2026-06-04T12:05:47.425246Z","steps":["trace[2134899763] 'process raft request' (duration: 122.080027ms)","trace[2134899763] 'compare' (duration: 11.042348ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T12:05:47.42588Z","caller":"traceutil/trace.go:171","msg":"trace[1900269811] transaction","detail":"{read_only:false; response_revision:2452; number_of_response:1; }","duration":"103.970619ms","start":"2026-06-04T12:05:47.321886Z","end":"2026-06-04T12:05:47.425857Z","steps":["trace[1900269811] 'process raft request' (duration: 103.284983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T12:05:52.215891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.800942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T12:05:52.216029Z","caller":"traceutil/trace.go:171","msg":"trace[1844812951] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"171.819438ms","start":"2026-06-04T12:05:52.044187Z","end":"2026-06-04T12:05:52.216006Z","steps":["trace[1844812951] 'process raft request' (duration: 13.818382ms)","trace[1844812951] 'compare' (duration: 157.650567ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T12:05:52.671155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.255768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-04T12:05:52.671187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.186704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-04T12:05:52.671253Z","caller":"traceutil/trace.go:171","msg":"trace[988385129] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2482; }","duration":"109.422972ms","start":"2026-06-04T12:05:52.561811Z","end":"2026-06-04T12:05:52.671234Z","steps":["trace[988385129] 'count revisions from in-memory index tree' (duration: 109.171837ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T12:05:52.671289Z","caller":"traceutil/trace.go:171","msg":"trace[1918064456] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2482; }","duration":"235.327796ms","start":"2026-06-04T12:05:52.435937Z","end":"2026-06-04T12:05:52.671265Z","steps":["trace[1918064456] 'range keys from in-memory index tree' (duration: 235.036009ms)"],"step_count":1}