{"level":"warn","ts":"2026-03-30T17:54:22.978291Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-30T17:54:22.978388Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.133:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.133:2380","--initial-cluster=instance=https://199.19.213.133:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.133:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.133: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-03-30T17:54:22.978457Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-30T17:54:22.97847Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.133:2380"]} {"level":"info","ts":"2026-03-30T17:54:22.978489Z","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-03-30T17:54:22.979175Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.133:2379"]} {"level":"info","ts":"2026-03-30T17:54:22.979304Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.133:2380"],"listen-peer-urls":["https://199.19.213.133:2380"],"advertise-client-urls":["https://199.19.213.133:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.133:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.133: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-03-30T17:54:22.985866Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.34736ms"} {"level":"info","ts":"2026-03-30T17:54:22.993849Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"21b354698260dd82","cluster-id":"b778216e1db811d5"} {"level":"info","ts":"2026-03-30T17:54:22.994078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 switched to configuration voters=()"} {"level":"info","ts":"2026-03-30T17:54:22.994142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became follower at term 0"} {"level":"info","ts":"2026-03-30T17:54:22.994228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 21b354698260dd82 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-30T17:54:22.994295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became follower at term 1"} {"level":"info","ts":"2026-03-30T17:54:22.994491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 switched to configuration voters=(2428377436218514818)"} {"level":"warn","ts":"2026-03-30T17:54:23.000359Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-30T17:54:23.002323Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-30T17:54:23.004032Z","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-03-30T17:54:23.009179Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"21b354698260dd82","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-30T17:54:23.010074Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"21b354698260dd82","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-30T17:54:23.010324Z","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-03-30T17:54:23.010399Z","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-03-30T17:54:23.010416Z","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-03-30T17:54:23.010704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 switched to configuration voters=(2428377436218514818)"} {"level":"info","ts":"2026-03-30T17:54:23.012761Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b778216e1db811d5","local-member-id":"21b354698260dd82","added-peer-id":"21b354698260dd82","added-peer-peer-urls":["https://199.19.213.133:2380"]} {"level":"info","ts":"2026-03-30T17:54:23.015091Z","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-03-30T17:54:23.015392Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.133:2380"} {"level":"info","ts":"2026-03-30T17:54:23.015494Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.133:2380"} {"level":"info","ts":"2026-03-30T17:54:23.015459Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"21b354698260dd82","initial-advertise-peer-urls":["https://199.19.213.133:2380"],"listen-peer-urls":["https://199.19.213.133:2380"],"advertise-client-urls":["https://199.19.213.133:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.133:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-30T17:54:23.015626Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-30T17:54:23.795448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 is starting a new election at term 1"} {"level":"info","ts":"2026-03-30T17:54:23.795553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-30T17:54:23.795592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 received MsgPreVoteResp from 21b354698260dd82 at term 1"} {"level":"info","ts":"2026-03-30T17:54:23.795614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became candidate at term 2"} {"level":"info","ts":"2026-03-30T17:54:23.795625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 received MsgVoteResp from 21b354698260dd82 at term 2"} {"level":"info","ts":"2026-03-30T17:54:23.795642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"21b354698260dd82 became leader at term 2"} {"level":"info","ts":"2026-03-30T17:54:23.795663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 21b354698260dd82 elected leader 21b354698260dd82 at term 2"} {"level":"info","ts":"2026-03-30T17:54:23.796696Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-30T17:54:23.797707Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-30T17:54:23.7977Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"21b354698260dd82","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.133:2379]}","request-path":"/0/members/21b354698260dd82/attributes","cluster-id":"b778216e1db811d5","publish-timeout":"7s"} {"level":"info","ts":"2026-03-30T17:54:23.798236Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-30T17:54:23.798308Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-30T17:54:23.798362Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b778216e1db811d5","local-member-id":"21b354698260dd82","cluster-version":"3.5"} {"level":"info","ts":"2026-03-30T17:54:23.798478Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-30T17:54:23.798518Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-30T17:54:23.80024Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.133:2379"} {"level":"info","ts":"2026-03-30T17:54:23.804799Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-30T17:54:23.806724Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-03-30T17:54:48.280072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.810839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:54:48.280076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.349803ms","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-03-30T17:54:48.28012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.258228ms","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-03-30T17:54:48.280162Z","caller":"traceutil/trace.go:171","msg":"trace[1277065652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:423; }","duration":"219.971952ms","start":"2026-03-30T17:54:48.060174Z","end":"2026-03-30T17:54:48.280146Z","steps":["trace[1277065652] 'range keys from in-memory index tree' (duration: 219.736767ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:54:48.280187Z","caller":"traceutil/trace.go:171","msg":"trace[1253408540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:423; }","duration":"570.518156ms","start":"2026-03-30T17:54:47.70965Z","end":"2026-03-30T17:54:48.280168Z","steps":["trace[1253408540] 'range keys from in-memory index tree' (duration: 570.263681ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:54:48.280201Z","caller":"traceutil/trace.go:171","msg":"trace[565070082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:423; }","duration":"588.422212ms","start":"2026-03-30T17:54:47.691759Z","end":"2026-03-30T17:54:48.280181Z","steps":["trace[565070082] 'range keys from in-memory index tree' (duration: 587.999113ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:48.280229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:47.709627Z","time spent":"570.592068ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-30T17:54:48.280253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:47.691733Z","time spent":"588.508344ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-30T17:54:48.907159Z","caller":"traceutil/trace.go:171","msg":"trace[1739383473] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"609.433087ms","start":"2026-03-30T17:54:48.297701Z","end":"2026-03-30T17:54:48.907134Z","steps":["trace[1739383473] 'process raft request' (duration: 609.290214ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:48.907849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:48.297685Z","time spent":"609.544681ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:54:48.913751Z","caller":"traceutil/trace.go:171","msg":"trace[373561998] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"615.956152ms","start":"2026-03-30T17:54:48.297756Z","end":"2026-03-30T17:54:48.913712Z","steps":["trace[373561998] 'process raft request' (duration: 615.729417ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:54:48.91368Z","caller":"traceutil/trace.go:171","msg":"trace[469031529] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"612.832843ms","start":"2026-03-30T17:54:48.300823Z","end":"2026-03-30T17:54:48.913655Z","steps":["trace[469031529] 'process raft request' (duration: 612.789492ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:48.913857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:48.297732Z","time spent":"616.069115ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:54:48.913939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:48.300815Z","time spent":"613.017287ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:54:53.629802Z","caller":"traceutil/trace.go:171","msg":"trace[289146833] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"116.449368ms","start":"2026-03-30T17:54:53.513327Z","end":"2026-03-30T17:54:53.629777Z","steps":["trace[289146833] 'process raft request' (duration: 116.293695ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:54.819819Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.009631631s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T17:54:54.820683Z","caller":"traceutil/trace.go:171","msg":"trace[1015101115] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"1.010600653s","start":"2026-03-30T17:54:53.810056Z","end":"2026-03-30T17:54:54.820657Z","steps":["trace[1015101115] 'process raft request' (duration: 1.010173893s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:54.820819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.810032Z","time spent":"1.010722035s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:55.251727Z","caller":"traceutil/trace.go:171","msg":"trace[101737733] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"1.437744663s","start":"2026-03-30T17:54:53.813958Z","end":"2026-03-30T17:54:55.251703Z","steps":["trace[101737733] 'process raft request' (duration: 1.437501327s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:55.251867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.813945Z","time spent":"1.437865575s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:55.251887Z","caller":"traceutil/trace.go:171","msg":"trace[1450717216] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"1.437495867s","start":"2026-03-30T17:54:53.814348Z","end":"2026-03-30T17:54:55.251844Z","steps":["trace[1450717216] 'process raft request' (duration: 1.437246201s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:54:55.251968Z","caller":"traceutil/trace.go:171","msg":"trace[2063647539] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"1.42998099s","start":"2026-03-30T17:54:53.821976Z","end":"2026-03-30T17:54:55.251957Z","steps":["trace[2063647539] 'process raft request' (duration: 1.429724095s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:55.252001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.82196Z","time spent":"1.430025471s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:55.252882Z","caller":"traceutil/trace.go:171","msg":"trace[838565595] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"1.417185738s","start":"2026-03-30T17:54:53.835661Z","end":"2026-03-30T17:54:55.252846Z","steps":["trace[838565595] 'process raft request' (duration: 1.416277877s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:55.252895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.814316Z","time spent":"1.437681251s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T17:54:55.253085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.835641Z","time spent":"1.41730857s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:55.253291Z","caller":"traceutil/trace.go:171","msg":"trace[310124841] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"1.411959551s","start":"2026-03-30T17:54:53.841315Z","end":"2026-03-30T17:54:55.253275Z","steps":["trace[310124841] 'process raft request' (duration: 1.410659872s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:55.253372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.841303Z","time spent":"1.412038183s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:55.259171Z","caller":"traceutil/trace.go:171","msg":"trace[1926199130] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"1.252905399s","start":"2026-03-30T17:54:54.006239Z","end":"2026-03-30T17:54:55.259145Z","steps":["trace[1926199130] 'process raft request' (duration: 1.252807706s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:55.259452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:54.006219Z","time spent":"1.25299904s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:55.259598Z","caller":"traceutil/trace.go:171","msg":"trace[363731027] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"1.427300551s","start":"2026-03-30T17:54:53.824679Z","end":"2026-03-30T17:54:55.25198Z","steps":["trace[363731027] 'process raft request' (duration: 1.427066456s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:55.259642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.824659Z","time spent":"1.43496115s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:55.259775Z","caller":"traceutil/trace.go:171","msg":"trace[1502193709] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"1.414426286s","start":"2026-03-30T17:54:53.84534Z","end":"2026-03-30T17:54:55.259766Z","steps":["trace[1502193709] 'process raft request' (duration: 1.413327702s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:55.259817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.845328Z","time spent":"1.414469137s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:55.259908Z","caller":"traceutil/trace.go:171","msg":"trace[963826494] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"1.414275093s","start":"2026-03-30T17:54:53.845622Z","end":"2026-03-30T17:54:55.259897Z","steps":["trace[963826494] 'process raft request' (duration: 1.413157119s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:55.259947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.845615Z","time spent":"1.414314304s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:55.262294Z","caller":"traceutil/trace.go:171","msg":"trace[678983317] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"1.38212888s","start":"2026-03-30T17:54:53.880144Z","end":"2026-03-30T17:54:55.262273Z","steps":["trace[678983317] 'process raft request' (duration: 1.378750025s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:55.262419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.880117Z","time spent":"1.382239973s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:55.262608Z","caller":"traceutil/trace.go:171","msg":"trace[296299367] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"1.421054933s","start":"2026-03-30T17:54:53.830962Z","end":"2026-03-30T17:54:55.252017Z","steps":["trace[296299367] 'process raft request' (duration: 1.42092581s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:55.262826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:53.830954Z","time spent":"1.431830291s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T17:54:56.263648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.758138ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T17:54:56.264063Z","caller":"traceutil/trace.go:171","msg":"trace[958182261] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"1.435829161s","start":"2026-03-30T17:54:54.828207Z","end":"2026-03-30T17:54:56.264036Z","steps":["trace[958182261] 'process raft request' (duration: 1.242293735s)","trace[958182261] 'compare' (duration: 192.344079ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:54:56.264167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:54.82818Z","time spent":"1.435942943s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:54:56.264409Z","caller":"traceutil/trace.go:171","msg":"trace[1503196073] transaction","detail":"{read_only:false; number_of_response:1; response_revision:484; }","duration":"1.435738689s","start":"2026-03-30T17:54:54.828644Z","end":"2026-03-30T17:54:56.264383Z","steps":["trace[1503196073] 'process raft request' (duration: 1.435615256s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:54:56.26458Z","caller":"traceutil/trace.go:171","msg":"trace[994441373] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"1.002392921s","start":"2026-03-30T17:54:55.262134Z","end":"2026-03-30T17:54:56.264527Z","steps":["trace[994441373] 'process raft request' (duration: 1.002227717s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:54:56.26467Z","caller":"traceutil/trace.go:171","msg":"trace[593748828] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:485; }","duration":"1.322104572s","start":"2026-03-30T17:54:54.942505Z","end":"2026-03-30T17:54:56.264609Z","steps":["trace[593748828] 'read index received' (duration: 308.963513ms)","trace[593748828] 'applied index is now lower than readState.Index' (duration: 1.013138389s)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:54:56.264784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.26209Z","time spent":"1.002596305s","remote":"127.0.0.1:60540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:56.264849Z","caller":"traceutil/trace.go:171","msg":"trace[463048667] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"944.307424ms","start":"2026-03-30T17:54:55.320516Z","end":"2026-03-30T17:54:56.264824Z","steps":["trace[463048667] 'process raft request' (duration: 944.269943ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.264964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.322456609s","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-03-30T17:54:56.26503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.32049Z","time spent":"944.422257ms","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:56.265063Z","caller":"traceutil/trace.go:171","msg":"trace[1443884387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:493; }","duration":"1.322600982s","start":"2026-03-30T17:54:54.94245Z","end":"2026-03-30T17:54:56.265051Z","steps":["trace[1443884387] 'agreement among raft nodes before linearized reading' (duration: 1.322382647s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.265102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:54.942429Z","time spent":"1.322663233s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-30T17:54:56.265274Z","caller":"traceutil/trace.go:171","msg":"trace[1110961468] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"987.522901ms","start":"2026-03-30T17:54:55.277734Z","end":"2026-03-30T17:54:56.265257Z","steps":["trace[1110961468] 'process raft request' (duration: 986.934838ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:54:56.265542Z","caller":"traceutil/trace.go:171","msg":"trace[1708779753] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"990.090958ms","start":"2026-03-30T17:54:55.275405Z","end":"2026-03-30T17:54:56.265496Z","steps":["trace[1708779753] 'process raft request' (duration: 989.064526ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.265626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.277726Z","time spent":"987.818028ms","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:54:56.265666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.275388Z","time spent":"990.19809ms","remote":"127.0.0.1:60540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:56.26584Z","caller":"traceutil/trace.go:171","msg":"trace[239157892] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"990.126499ms","start":"2026-03-30T17:54:55.275692Z","end":"2026-03-30T17:54:56.265818Z","steps":["trace[239157892] 'process raft request' (duration: 988.849351ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:54:56.265879Z","caller":"traceutil/trace.go:171","msg":"trace[954396137] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"990.351164ms","start":"2026-03-30T17:54:55.275517Z","end":"2026-03-30T17:54:56.265868Z","steps":["trace[954396137] 'process raft request' (duration: 988.985614ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.265932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.275499Z","time spent":"990.407665ms","remote":"127.0.0.1:60540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T17:54:56.265929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.275674Z","time spent":"990.20601ms","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:54:56.26612Z","caller":"traceutil/trace.go:171","msg":"trace[650680457] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"989.534816ms","start":"2026-03-30T17:54:55.276568Z","end":"2026-03-30T17:54:56.266102Z","steps":["trace[650680457] 'process raft request' (duration: 988.033713ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.266197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.276561Z","time spent":"989.592148ms","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:54:56.265243Z","caller":"traceutil/trace.go:171","msg":"trace[42958174] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"989.907474ms","start":"2026-03-30T17:54:55.275298Z","end":"2026-03-30T17:54:56.265206Z","steps":["trace[42958174] 'process raft request' (duration: 989.137257ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.266392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.27528Z","time spent":"991.077801ms","remote":"127.0.0.1:60540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T17:54:56.266868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:54.828631Z","time spent":"1.43582593s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:54:56.269231Z","caller":"traceutil/trace.go:171","msg":"trace[1152946661] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"987.147643ms","start":"2026-03-30T17:54:55.278109Z","end":"2026-03-30T17:54:56.265256Z","steps":["trace[1152946661] 'process raft request' (duration: 986.618551ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.269367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.278101Z","time spent":"991.189933ms","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:54:56.264425Z","caller":"traceutil/trace.go:171","msg":"trace[421720291] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"1.435883152s","start":"2026-03-30T17:54:54.828475Z","end":"2026-03-30T17:54:56.264358Z","steps":["trace[421720291] 'process raft request' (duration: 1.43532932s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.27317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:54.828463Z","time spent":"1.444653936s","remote":"127.0.0.1:60540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:54:56.277265Z","caller":"traceutil/trace.go:171","msg":"trace[1742219846] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"131.501352ms","start":"2026-03-30T17:54:56.145741Z","end":"2026-03-30T17:54:56.277242Z","steps":["trace[1742219846] 'process raft request' (duration: 131.381099ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.277686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331186523s","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-03-30T17:54:56.277726Z","caller":"traceutil/trace.go:171","msg":"trace[2114798221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:494; }","duration":"1.331256315s","start":"2026-03-30T17:54:54.946459Z","end":"2026-03-30T17:54:56.277715Z","steps":["trace[2114798221] 'agreement among raft nodes before linearized reading' (duration: 1.331182993s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.277749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:54.946448Z","time spent":"1.331295186s","remote":"127.0.0.1:60258","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-03-30T17:54:56.277851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.583604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-30T17:54:56.277875Z","caller":"traceutil/trace.go:171","msg":"trace[1993015724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:494; }","duration":"643.644115ms","start":"2026-03-30T17:54:55.634226Z","end":"2026-03-30T17:54:56.27787Z","steps":["trace[1993015724] 'agreement among raft nodes before linearized reading' (duration: 643.600834ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.277892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.634203Z","time spent":"643.685677ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-30T17:54:56.277975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.218044297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:54:56.277992Z","caller":"traceutil/trace.go:171","msg":"trace[1013559902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:494; }","duration":"1.218086778s","start":"2026-03-30T17:54:55.059899Z","end":"2026-03-30T17:54:56.277986Z","steps":["trace[1013559902] 'agreement among raft nodes before linearized reading' (duration: 1.218059537s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.278008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:55.059872Z","time spent":"1.218132109s","remote":"127.0.0.1:50238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T17:54:56.278188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.328161635s","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-03-30T17:54:56.278237Z","caller":"traceutil/trace.go:171","msg":"trace[448436917] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:494; }","duration":"1.328232897s","start":"2026-03-30T17:54:54.949992Z","end":"2026-03-30T17:54:56.278225Z","steps":["trace[448436917] 'agreement among raft nodes before linearized reading' (duration: 1.328139735s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:54:56.278268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:54:54.949981Z","time spent":"1.328282658s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-30T17:55:02.611965Z","caller":"traceutil/trace.go:171","msg":"trace[930788493] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"258.323171ms","start":"2026-03-30T17:55:02.353618Z","end":"2026-03-30T17:55:02.611941Z","steps":["trace[930788493] 'process raft request' (duration: 258.123046ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:02.800928Z","caller":"traceutil/trace.go:171","msg":"trace[1212354058] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"446.935288ms","start":"2026-03-30T17:55:02.353967Z","end":"2026-03-30T17:55:02.800902Z","steps":["trace[1212354058] 'process raft request' (duration: 446.615111ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:02.801104Z","caller":"traceutil/trace.go:171","msg":"trace[1002643546] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"446.56104ms","start":"2026-03-30T17:55:02.354505Z","end":"2026-03-30T17:55:02.801066Z","steps":["trace[1002643546] 'process raft request' (duration: 446.294864ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.801216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:02.353947Z","time spent":"447.136232ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:55:02.801356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:02.354472Z","time spent":"446.716413ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:55:02.802155Z","caller":"traceutil/trace.go:171","msg":"trace[2098183995] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:597; }","duration":"422.705152ms","start":"2026-03-30T17:55:02.379413Z","end":"2026-03-30T17:55:02.802118Z","steps":["trace[2098183995] 'read index received' (duration: 232.485939ms)","trace[2098183995] 'applied index is now lower than readState.Index' (duration: 190.217463ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:55:02.80236Z","caller":"traceutil/trace.go:171","msg":"trace[534563673] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"445.258971ms","start":"2026-03-30T17:55:02.357069Z","end":"2026-03-30T17:55:02.802328Z","steps":["trace[534563673] 'process raft request' (duration: 444.32626ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:02.802641Z","caller":"traceutil/trace.go:171","msg":"trace[1577391903] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"434.565925ms","start":"2026-03-30T17:55:02.368062Z","end":"2026-03-30T17:55:02.802628Z","steps":["trace[1577391903] 'process raft request' (duration: 434.001892ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.802746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.242184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.802836Z","caller":"traceutil/trace.go:171","msg":"trace[248167590] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:582; }","duration":"423.356546ms","start":"2026-03-30T17:55:02.379468Z","end":"2026-03-30T17:55:02.802824Z","steps":["trace[248167590] 'agreement among raft nodes before linearized reading' (duration: 423.188732ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.802799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:02.368053Z","time spent":"434.644626ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:55:02.802869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.005286ms","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":"warn","ts":"2026-03-30T17:55:02.802916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:02.37946Z","time spent":"423.419167ms","remote":"127.0.0.1:33214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:55:02.803008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.592552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:02.803034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.285124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.803064Z","caller":"traceutil/trace.go:171","msg":"trace[573194539] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:582; }","duration":"423.640793ms","start":"2026-03-30T17:55:02.379405Z","end":"2026-03-30T17:55:02.803046Z","steps":["trace[573194539] 'agreement among raft nodes before linearized reading' (duration: 423.578061ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.803115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.451728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:02.80309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:02.357053Z","time spent":"445.675461ms","remote":"127.0.0.1:60092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:55:02.803201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.266671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:02.803217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.412481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.803267Z","caller":"traceutil/trace.go:171","msg":"trace[1599184876] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:582; }","duration":"156.349943ms","start":"2026-03-30T17:55:02.6469Z","end":"2026-03-30T17:55:02.80325Z","steps":["trace[1599184876] 'agreement among raft nodes before linearized reading' (duration: 156.272212ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:02.803269Z","caller":"traceutil/trace.go:171","msg":"trace[534772038] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:582; }","duration":"243.470362ms","start":"2026-03-30T17:55:02.559786Z","end":"2026-03-30T17:55:02.803256Z","steps":["trace[534772038] 'agreement among raft nodes before linearized reading' (duration: 243.37823ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.803309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.325471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.803374Z","caller":"traceutil/trace.go:171","msg":"trace[603371780] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:582; }","duration":"272.423134ms","start":"2026-03-30T17:55:02.530931Z","end":"2026-03-30T17:55:02.803354Z","steps":["trace[603371780] 'agreement among raft nodes before linearized reading' (duration: 272.323211ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.803443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.460478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.803491Z","caller":"traceutil/trace.go:171","msg":"trace[1789073723] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:582; }","duration":"423.598501ms","start":"2026-03-30T17:55:02.379884Z","end":"2026-03-30T17:55:02.803483Z","steps":["trace[1789073723] 'agreement among raft nodes before linearized reading' (duration: 423.458998ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.803546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.16367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:02.803556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.695911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:02.80356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.25814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.803594Z","caller":"traceutil/trace.go:171","msg":"trace[1648804398] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:582; }","duration":"212.22447ms","start":"2026-03-30T17:55:02.591357Z","end":"2026-03-30T17:55:02.803582Z","steps":["trace[1648804398] 'agreement among raft nodes before linearized reading' (duration: 212.162519ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.80364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.579707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.803677Z","caller":"traceutil/trace.go:171","msg":"trace[2128804017] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:582; }","duration":"272.654678ms","start":"2026-03-30T17:55:02.531013Z","end":"2026-03-30T17:55:02.803667Z","steps":["trace[2128804017] 'agreement among raft nodes before linearized reading' (duration: 272.607147ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.803496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.697368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.803774Z","caller":"traceutil/trace.go:171","msg":"trace[1874582925] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:582; }","duration":"211.987594ms","start":"2026-03-30T17:55:02.591777Z","end":"2026-03-30T17:55:02.803764Z","steps":["trace[1874582925] 'agreement among raft nodes before linearized reading' (duration: 211.687908ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.803818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.480236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.803854Z","caller":"traceutil/trace.go:171","msg":"trace[1528895359] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:582; }","duration":"212.528197ms","start":"2026-03-30T17:55:02.591316Z","end":"2026-03-30T17:55:02.803845Z","steps":["trace[1528895359] 'agreement among raft nodes before linearized reading' (duration: 212.477006ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.803863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.969143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.803595Z","caller":"traceutil/trace.go:171","msg":"trace[1401783432] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:582; }","duration":"156.739782ms","start":"2026-03-30T17:55:02.646845Z","end":"2026-03-30T17:55:02.803584Z","steps":["trace[1401783432] 'agreement among raft nodes before linearized reading' (duration: 156.67288ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:02.803917Z","caller":"traceutil/trace.go:171","msg":"trace[1689431734] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:582; }","duration":"244.037564ms","start":"2026-03-30T17:55:02.559864Z","end":"2026-03-30T17:55:02.803902Z","steps":["trace[1689431734] 'agreement among raft nodes before linearized reading' (duration: 243.959263ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.803939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.252255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:02.803553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:02.379873Z","time spent":"423.670454ms","remote":"127.0.0.1:33214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"info","ts":"2026-03-30T17:55:02.804046Z","caller":"traceutil/trace.go:171","msg":"trace[313179524] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:582; }","duration":"242.358948ms","start":"2026-03-30T17:55:02.561649Z","end":"2026-03-30T17:55:02.804008Z","steps":["trace[313179524] 'agreement among raft nodes before linearized reading' (duration: 242.185094ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.803113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:02.379342Z","time spent":"423.760245ms","remote":"127.0.0.1:33214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-03-30T17:55:02.803067Z","caller":"traceutil/trace.go:171","msg":"trace[687399252] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:582; }","duration":"106.366126ms","start":"2026-03-30T17:55:02.696692Z","end":"2026-03-30T17:55:02.803058Z","steps":["trace[687399252] 'agreement among raft nodes before linearized reading' (duration: 106.314115ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:02.803152Z","caller":"traceutil/trace.go:171","msg":"trace[122088285] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:582; }","duration":"106.510679ms","start":"2026-03-30T17:55:02.696632Z","end":"2026-03-30T17:55:02.803143Z","steps":["trace[122088285] 'agreement among raft nodes before linearized reading' (duration: 106.460738ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:02.802941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.115369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:02.804251Z","caller":"traceutil/trace.go:171","msg":"trace[2137800900] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:582; }","duration":"106.469448ms","start":"2026-03-30T17:55:02.69777Z","end":"2026-03-30T17:55:02.80424Z","steps":["trace[2137800900] 'agreement among raft nodes before linearized reading' (duration: 105.010766ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:02.803601Z","caller":"traceutil/trace.go:171","msg":"trace[1456171677] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:582; }","duration":"272.312191ms","start":"2026-03-30T17:55:02.53128Z","end":"2026-03-30T17:55:02.803592Z","steps":["trace[1456171677] 'agreement among raft nodes before linearized reading' (duration: 272.253699ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:02.802967Z","caller":"traceutil/trace.go:171","msg":"trace[1760261991] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:582; }","duration":"156.160068ms","start":"2026-03-30T17:55:02.646778Z","end":"2026-03-30T17:55:02.802938Z","steps":["trace[1760261991] 'agreement among raft nodes before linearized reading' (duration: 155.921363ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:02.991767Z","caller":"traceutil/trace.go:171","msg":"trace[570591293] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"121.801948ms","start":"2026-03-30T17:55:02.869936Z","end":"2026-03-30T17:55:02.991738Z","steps":["trace[570591293] 'process raft request' (duration: 121.668905ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:03.631826Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492927053076188,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T17:55:03.900077Z","caller":"traceutil/trace.go:171","msg":"trace[445963946] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"875.568562ms","start":"2026-03-30T17:55:03.024478Z","end":"2026-03-30T17:55:03.900047Z","steps":["trace[445963946] 'process raft request' (duration: 875.224564ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:03.900254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.024467Z","time spent":"875.691135ms","remote":"127.0.0.1:60168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:55:05.262988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.751235ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.263097Z","caller":"traceutil/trace.go:171","msg":"trace[1396970660] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:584; }","duration":"796.874217ms","start":"2026-03-30T17:55:04.466204Z","end":"2026-03-30T17:55:05.263079Z","steps":["trace[1396970660] 'range keys from in-memory index tree' (duration: 796.736835ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.263532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.30014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T17:55:05.263694Z","caller":"traceutil/trace.go:171","msg":"trace[1753346650] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:603; }","duration":"2.132791943s","start":"2026-03-30T17:55:03.13085Z","end":"2026-03-30T17:55:05.263642Z","steps":["trace[1753346650] 'read index received' (duration: 769.129395ms)","trace[1753346650] 'applied index is now lower than readState.Index' (duration: 1.363660548s)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:55:05.263708Z","caller":"traceutil/trace.go:171","msg":"trace[706338261] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.847169787s","start":"2026-03-30T17:55:03.416506Z","end":"2026-03-30T17:55:05.263676Z","steps":["trace[706338261] 'process raft request' (duration: 1.346622182s)","trace[706338261] 'compare' (duration: 499.916432ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:55:05.263832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.41648Z","time spent":"1.847281599s","remote":"127.0.0.1:60092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:55:05.26384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.132971246s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.26389Z","caller":"traceutil/trace.go:171","msg":"trace[1818557722] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"2.133043299s","start":"2026-03-30T17:55:03.130828Z","end":"2026-03-30T17:55:05.263871Z","steps":["trace[1818557722] 'agreement among raft nodes before linearized reading' (duration: 2.132957027s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.263954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.13081Z","time spent":"2.13312943s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-30T17:55:05.264119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.133213992s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.264164Z","caller":"traceutil/trace.go:171","msg":"trace[1167290317] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"2.133274995s","start":"2026-03-30T17:55:03.130877Z","end":"2026-03-30T17:55:05.264152Z","steps":["trace[1167290317] 'agreement among raft nodes before linearized reading' (duration: 2.133194772s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.335903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-30T17:55:05.264192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.130874Z","time spent":"2.133311426s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-03-30T17:55:05.264257Z","caller":"traceutil/trace.go:171","msg":"trace[1280149104] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"454.398185ms","start":"2026-03-30T17:55:04.80985Z","end":"2026-03-30T17:55:05.264248Z","steps":["trace[1280149104] 'agreement among raft nodes before linearized reading' (duration: 454.294292ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.016303183s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.264278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:04.809837Z","time spent":"454.436725ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-30T17:55:05.264299Z","caller":"traceutil/trace.go:171","msg":"trace[819916917] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:585; }","duration":"2.016344995s","start":"2026-03-30T17:55:03.247943Z","end":"2026-03-30T17:55:05.264288Z","steps":["trace[819916917] 'agreement among raft nodes before linearized reading' (duration: 2.016298214s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.247936Z","time spent":"2.016379055s","remote":"127.0.0.1:33344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-03-30T17:55:05.264335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.983580699s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.26438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.953710047s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.264456Z","caller":"traceutil/trace.go:171","msg":"trace[697433180] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:585; }","duration":"1.953806129s","start":"2026-03-30T17:55:03.310636Z","end":"2026-03-30T17:55:05.264442Z","steps":["trace[697433180] 'agreement among raft nodes before linearized reading' (duration: 1.953702157s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:05.264463Z","caller":"traceutil/trace.go:171","msg":"trace[2094216961] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:585; }","duration":"1.983766414s","start":"2026-03-30T17:55:03.280667Z","end":"2026-03-30T17:55:05.264434Z","steps":["trace[2094216961] 'agreement among raft nodes before linearized reading' (duration: 1.983502078s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.01706245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.264513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.088685ms","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-03-30T17:55:05.26451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.310621Z","time spent":"1.953876091s","remote":"127.0.0.1:33348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-03-30T17:55:05.264532Z","caller":"traceutil/trace.go:171","msg":"trace[104180244] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:585; }","duration":"2.017097751s","start":"2026-03-30T17:55:03.247424Z","end":"2026-03-30T17:55:05.264522Z","steps":["trace[104180244] 'agreement among raft nodes before linearized reading' (duration: 2.01706472s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:05.264535Z","caller":"traceutil/trace.go:171","msg":"trace[266065653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:585; }","duration":"644.139146ms","start":"2026-03-30T17:55:04.620389Z","end":"2026-03-30T17:55:05.264528Z","steps":["trace[266065653] 'agreement among raft nodes before linearized reading' (duration: 644.094115ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.280655Z","time spent":"1.983862376s","remote":"127.0.0.1:33346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-30T17:55:05.264581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.203745427s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.264608Z","caller":"traceutil/trace.go:171","msg":"trace[1318128598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"1.203795059s","start":"2026-03-30T17:55:04.060805Z","end":"2026-03-30T17:55:05.2646Z","steps":["trace[1318128598] 'agreement among raft nodes before linearized reading' (duration: 1.203761298s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:04.060789Z","time spent":"1.203831139s","remote":"127.0.0.1:50238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T17:55:05.264675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.983930227s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.264706Z","caller":"traceutil/trace.go:171","msg":"trace[189077287] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:585; }","duration":"1.983991329s","start":"2026-03-30T17:55:03.280708Z","end":"2026-03-30T17:55:05.264699Z","steps":["trace[189077287] 'agreement among raft nodes before linearized reading' (duration: 1.983942038s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.887706885s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.264729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.953986003s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.264728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.280687Z","time spent":"1.984033999s","remote":"127.0.0.1:33346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-03-30T17:55:05.264761Z","caller":"traceutil/trace.go:171","msg":"trace[1928810645] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"1.887744406s","start":"2026-03-30T17:55:03.377009Z","end":"2026-03-30T17:55:05.264753Z","steps":["trace[1928810645] 'agreement among raft nodes before linearized reading' (duration: 1.887701595s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.376991Z","time spent":"1.887784826s","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-03-30T17:55:05.264419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.867957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-30T17:55:05.264822Z","caller":"traceutil/trace.go:171","msg":"trace[2135673515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"456.301476ms","start":"2026-03-30T17:55:04.80851Z","end":"2026-03-30T17:55:05.264811Z","steps":["trace[2135673515] 'agreement among raft nodes before linearized reading' (duration: 455.859367ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.067771523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.264555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:04.620371Z","time spent":"644.180667ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-30T17:55:05.264891Z","caller":"traceutil/trace.go:171","msg":"trace[532501772] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:585; }","duration":"2.067812954s","start":"2026-03-30T17:55:03.19707Z","end":"2026-03-30T17:55:05.264883Z","steps":["trace[532501772] 'agreement among raft nodes before linearized reading' (duration: 2.067775573s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.888477042s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.264936Z","caller":"traceutil/trace.go:171","msg":"trace[1674128165] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"1.888513483s","start":"2026-03-30T17:55:03.376416Z","end":"2026-03-30T17:55:05.26493Z","steps":["trace[1674128165] 'agreement among raft nodes before linearized reading' (duration: 1.888473492s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.26495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.078176814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.264964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.376411Z","time spent":"1.888546223s","remote":"127.0.0.1:33388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-03-30T17:55:05.264973Z","caller":"traceutil/trace.go:171","msg":"trace[2086971483] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:585; }","duration":"2.078203845s","start":"2026-03-30T17:55:03.186762Z","end":"2026-03-30T17:55:05.264965Z","steps":["trace[2086971483] 'agreement among raft nodes before linearized reading' (duration: 2.078167884s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.067306183s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.265027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.186759Z","time spent":"2.078230515s","remote":"127.0.0.1:33326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:55:05.2651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.888691446s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.265127Z","caller":"traceutil/trace.go:171","msg":"trace[754924558] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"1.888735728s","start":"2026-03-30T17:55:03.376384Z","end":"2026-03-30T17:55:05.26512Z","steps":["trace[754924558] 'agreement among raft nodes before linearized reading' (duration: 1.888695697s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.273516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-30T17:55:05.265123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.100731654s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.265148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.376375Z","time spent":"1.888766688s","remote":"127.0.0.1:33388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:55:05.264124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.953380499s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.265171Z","caller":"traceutil/trace.go:171","msg":"trace[311521172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:585; }","duration":"457.026803ms","start":"2026-03-30T17:55:04.808129Z","end":"2026-03-30T17:55:05.265156Z","steps":["trace[311521172] 'agreement among raft nodes before linearized reading' (duration: 456.305377ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.265214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.078395619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.265228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:04.808097Z","time spent":"457.118944ms","remote":"127.0.0.1:60258","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-03-30T17:55:05.26523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.100658012s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.265269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.90190036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.265278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.078515731s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.265181Z","caller":"traceutil/trace.go:171","msg":"trace[66394102] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:585; }","duration":"1.954454134s","start":"2026-03-30T17:55:03.310717Z","end":"2026-03-30T17:55:05.265171Z","steps":["trace[66394102] 'agreement among raft nodes before linearized reading' (duration: 1.953368379s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:05.265276Z","caller":"traceutil/trace.go:171","msg":"trace[48059018] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"2.100714083s","start":"2026-03-30T17:55:03.164551Z","end":"2026-03-30T17:55:05.265265Z","steps":["trace[48059018] 'agreement among raft nodes before linearized reading' (duration: 2.100648422s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:05.265292Z","caller":"traceutil/trace.go:171","msg":"trace[388088686] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"1.901948331s","start":"2026-03-30T17:55:03.363337Z","end":"2026-03-30T17:55:05.265285Z","steps":["trace[388088686] 'agreement among raft nodes before linearized reading' (duration: 1.90191572s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:05.265299Z","caller":"traceutil/trace.go:171","msg":"trace[849550199] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:585; }","duration":"2.078560162s","start":"2026-03-30T17:55:03.186733Z","end":"2026-03-30T17:55:05.265293Z","steps":["trace[849550199] 'agreement among raft nodes before linearized reading' (duration: 2.078522921s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.265323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.186721Z","time spent":"2.078594903s","remote":"127.0.0.1:33326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-30T17:55:05.265328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.36332Z","time spent":"1.901989772s","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-03-30T17:55:05.265322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.164546Z","time spent":"2.100761994s","remote":"127.0.0.1:33316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-30T17:55:05.26543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.921789741s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.264832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.100242742s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.265457Z","caller":"traceutil/trace.go:171","msg":"trace[288562220] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"1.921866702s","start":"2026-03-30T17:55:03.343582Z","end":"2026-03-30T17:55:05.265449Z","steps":["trace[288562220] 'agreement among raft nodes before linearized reading' (duration: 1.921828421s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.265237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.901781087s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.265493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.343574Z","time spent":"1.921913193s","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-03-30T17:55:05.265486Z","caller":"traceutil/trace.go:171","msg":"trace[255267951] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"2.100890476s","start":"2026-03-30T17:55:03.164573Z","end":"2026-03-30T17:55:05.265463Z","steps":["trace[255267951] 'agreement among raft nodes before linearized reading' (duration: 2.100234232s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.265449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.310709Z","time spent":"1.954597497s","remote":"127.0.0.1:33348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-03-30T17:55:05.265628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.922518656s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.265651Z","caller":"traceutil/trace.go:171","msg":"trace[1040187744] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"1.922561627s","start":"2026-03-30T17:55:03.343082Z","end":"2026-03-30T17:55:05.265643Z","steps":["trace[1040187744] 'agreement among raft nodes before linearized reading' (duration: 1.922529827s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.247417Z","time spent":"2.017132381s","remote":"127.0.0.1:33344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"info","ts":"2026-03-30T17:55:05.265513Z","caller":"traceutil/trace.go:171","msg":"trace[1081654483] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"1.902049873s","start":"2026-03-30T17:55:03.363449Z","end":"2026-03-30T17:55:05.265498Z","steps":["trace[1081654483] 'agreement among raft nodes before linearized reading' (duration: 1.901768937s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.265687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.36339Z","time spent":"1.902291618s","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:55:05.26447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.0170245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.26513Z","caller":"traceutil/trace.go:171","msg":"trace[1653430649] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:585; }","duration":"2.067683561s","start":"2026-03-30T17:55:03.197348Z","end":"2026-03-30T17:55:05.265031Z","steps":["trace[1653430649] 'agreement among raft nodes before linearized reading' (duration: 2.067154039s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.265834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.197342Z","time spent":"2.068481718s","remote":"127.0.0.1:33340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-03-30T17:55:05.265825Z","caller":"traceutil/trace.go:171","msg":"trace[1517917366] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:585; }","duration":"2.018390979s","start":"2026-03-30T17:55:03.24742Z","end":"2026-03-30T17:55:05.265811Z","steps":["trace[1517917366] 'agreement among raft nodes before linearized reading' (duration: 2.017027599s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:05.265174Z","caller":"traceutil/trace.go:171","msg":"trace[335315192] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:585; }","duration":"2.100805055s","start":"2026-03-30T17:55:03.164354Z","end":"2026-03-30T17:55:05.265159Z","steps":["trace[335315192] 'agreement among raft nodes before linearized reading' (duration: 2.100728603s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.265876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.164342Z","time spent":"2.10152223s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-30T17:55:05.265884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.247408Z","time spent":"2.01845364s","remote":"127.0.0.1:33344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:55:05.264873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:04.808484Z","time spent":"456.376278ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-30T17:55:05.265597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.922458284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.266053Z","caller":"traceutil/trace.go:171","msg":"trace[1059867013] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"1.922924075s","start":"2026-03-30T17:55:03.343105Z","end":"2026-03-30T17:55:05.266029Z","steps":["trace[1059867013] 'agreement among raft nodes before linearized reading' (duration: 1.922470195s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.266081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.343089Z","time spent":"1.922985656s","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:55:05.265784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.939648545s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.266126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.939987643s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.265576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.164569Z","time spent":"2.100987928s","remote":"127.0.0.1:33316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-03-30T17:55:05.266182Z","caller":"traceutil/trace.go:171","msg":"trace[1811243009] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:585; }","duration":"1.940071325s","start":"2026-03-30T17:55:03.326096Z","end":"2026-03-30T17:55:05.266168Z","steps":["trace[1811243009] 'agreement among raft nodes before linearized reading' (duration: 1.939988243s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.266236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.32608Z","time spent":"1.940141616s","remote":"127.0.0.1:33362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-03-30T17:55:05.264778Z","caller":"traceutil/trace.go:171","msg":"trace[569890230] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:585; }","duration":"1.954064755s","start":"2026-03-30T17:55:03.310698Z","end":"2026-03-30T17:55:05.264763Z","steps":["trace[569890230] 'agreement among raft nodes before linearized reading' (duration: 1.953989093s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.265978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.343072Z","time spent":"1.922899104s","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-03-30T17:55:05.266296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.940171806s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:05.266338Z","caller":"traceutil/trace.go:171","msg":"trace[1550577041] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:585; }","duration":"1.940232318s","start":"2026-03-30T17:55:03.326096Z","end":"2026-03-30T17:55:05.266328Z","steps":["trace[1550577041] 'agreement among raft nodes before linearized reading' (duration: 1.940165037s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.264217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.065619066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.266289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.310681Z","time spent":"1.955596208s","remote":"127.0.0.1:33348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-03-30T17:55:05.266392Z","caller":"traceutil/trace.go:171","msg":"trace[1409803852] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:585; }","duration":"2.067826954s","start":"2026-03-30T17:55:03.198557Z","end":"2026-03-30T17:55:05.266384Z","steps":["trace[1409803852] 'agreement among raft nodes before linearized reading' (duration: 2.065567434s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.266438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.198545Z","time spent":"2.067881705s","remote":"127.0.0.1:33340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-30T17:55:05.264915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.197061Z","time spent":"2.067846704s","remote":"127.0.0.1:33340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-30T17:55:05.266648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.326088Z","time spent":"1.940546315s","remote":"127.0.0.1:33362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"info","ts":"2026-03-30T17:55:05.26524Z","caller":"traceutil/trace.go:171","msg":"trace[420790273] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:585; }","duration":"2.07849954s","start":"2026-03-30T17:55:03.186733Z","end":"2026-03-30T17:55:05.265233Z","steps":["trace[420790273] 'agreement among raft nodes before linearized reading' (duration: 2.078399808s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:05.266131Z","caller":"traceutil/trace.go:171","msg":"trace[1306130686] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:585; }","duration":"1.939999043s","start":"2026-03-30T17:55:03.326119Z","end":"2026-03-30T17:55:05.266118Z","steps":["trace[1306130686] 'agreement among raft nodes before linearized reading' (duration: 1.939644625s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.266707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.186714Z","time spent":"2.079980413s","remote":"127.0.0.1:33326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-30T17:55:05.26672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:03.326115Z","time spent":"1.940597016s","remote":"127.0.0.1:33362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:55:05.87258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.954408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T17:55:05.87266Z","caller":"traceutil/trace.go:171","msg":"trace[227118972] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"599.833742ms","start":"2026-03-30T17:55:05.27281Z","end":"2026-03-30T17:55:05.872644Z","steps":["trace[227118972] 'process raft request' (duration: 380.752171ms)","trace[227118972] 'compare' (duration: 218.730484ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:55:05.872697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:05.272795Z","time spent":"599.884674ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:55:05.968832Z","caller":"traceutil/trace.go:171","msg":"trace[1432134903] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"695.058392ms","start":"2026-03-30T17:55:05.273746Z","end":"2026-03-30T17:55:05.968804Z","steps":["trace[1432134903] 'process raft request' (duration: 694.932629ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.969036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:05.27374Z","time spent":"695.179114ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:55:05.969219Z","caller":"traceutil/trace.go:171","msg":"trace[633227005] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"694.769435ms","start":"2026-03-30T17:55:05.274434Z","end":"2026-03-30T17:55:05.969204Z","steps":["trace[633227005] 'process raft request' (duration: 694.310415ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.969327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.650229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:05.969354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:05.274426Z","time spent":"694.854777ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:55:05.969386Z","caller":"traceutil/trace.go:171","msg":"trace[1834598363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"692.756171ms","start":"2026-03-30T17:55:05.27662Z","end":"2026-03-30T17:55:05.969376Z","steps":["trace[1834598363] 'agreement among raft nodes before linearized reading' (duration: 692.637339ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.969596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:05.276611Z","time spent":"692.970826ms","remote":"127.0.0.1:50238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T17:55:05.969232Z","caller":"traceutil/trace.go:171","msg":"trace[745199190] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:605; }","duration":"692.552967ms","start":"2026-03-30T17:55:05.276665Z","end":"2026-03-30T17:55:05.969218Z","steps":["trace[745199190] 'read index received' (duration: 376.899627ms)","trace[745199190] 'applied index is now lower than readState.Index' (duration: 315.65225ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:55:05.969523Z","caller":"traceutil/trace.go:171","msg":"trace[188332647] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"632.420204ms","start":"2026-03-30T17:55:05.337094Z","end":"2026-03-30T17:55:05.969514Z","steps":["trace[188332647] 'process raft request' (duration: 631.881892ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.969751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:05.33706Z","time spent":"632.65636ms","remote":"127.0.0.1:60230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:55:05.968875Z","caller":"traceutil/trace.go:171","msg":"trace[1651231527] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"695.180444ms","start":"2026-03-30T17:55:05.273634Z","end":"2026-03-30T17:55:05.968814Z","steps":["trace[1651231527] 'process raft request' (duration: 694.886087ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:05.969893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:05.273622Z","time spent":"696.239468ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:55:14.141613Z","caller":"traceutil/trace.go:171","msg":"trace[844271275] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:720; }","duration":"128.907255ms","start":"2026-03-30T17:55:14.012675Z","end":"2026-03-30T17:55:14.141583Z","steps":["trace[844271275] 'read index received' (duration: 108.423112ms)","trace[844271275] 'applied index is now lower than readState.Index' (duration: 20.483113ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:55:14.142056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.308425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-30T17:55:14.142101Z","caller":"traceutil/trace.go:171","msg":"trace[32378230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:698; }","duration":"129.427367ms","start":"2026-03-30T17:55:14.012662Z","end":"2026-03-30T17:55:14.14209Z","steps":["trace[32378230] 'agreement among raft nodes before linearized reading' (duration: 129.08505ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:14.142059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.004897ms","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-03-30T17:55:14.14216Z","caller":"traceutil/trace.go:171","msg":"trace[1462065579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:698; }","duration":"124.129279ms","start":"2026-03-30T17:55:14.018009Z","end":"2026-03-30T17:55:14.142138Z","steps":["trace[1462065579] 'agreement among raft nodes before linearized reading' (duration: 123.835533ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:14.142312Z","caller":"traceutil/trace.go:171","msg":"trace[2346125] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"131.433451ms","start":"2026-03-30T17:55:14.01034Z","end":"2026-03-30T17:55:14.141774Z","steps":["trace[2346125] 'process raft request' (duration: 110.815834ms)","trace[2346125] 'compare' (duration: 20.293309ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:55:22.037265Z","caller":"traceutil/trace.go:171","msg":"trace[1816088505] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"134.417597ms","start":"2026-03-30T17:55:21.902815Z","end":"2026-03-30T17:55:22.037232Z","steps":["trace[1816088505] 'process raft request' (duration: 134.223103ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:47.413856Z","caller":"traceutil/trace.go:171","msg":"trace[84807812] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"113.78312ms","start":"2026-03-30T17:55:47.300057Z","end":"2026-03-30T17:55:47.41384Z","steps":["trace[84807812] 'process raft request' (duration: 113.660007ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:56.652683Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.209596819s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T17:55:56.653139Z","caller":"traceutil/trace.go:171","msg":"trace[1999896708] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:997; }","duration":"457.174791ms","start":"2026-03-30T17:55:56.195942Z","end":"2026-03-30T17:55:56.653117Z","steps":["trace[1999896708] 'read index received' (duration: 456.894505ms)","trace[1999896708] 'applied index is now lower than readState.Index' (duration: 279.466µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:55:56.65323Z","caller":"traceutil/trace.go:171","msg":"trace[783443235] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"1.210247403s","start":"2026-03-30T17:55:55.44296Z","end":"2026-03-30T17:55:56.653208Z","steps":["trace[783443235] 'process raft request' (duration: 1.209944486s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:56.653469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.920627ms","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-03-30T17:55:56.653529Z","caller":"traceutil/trace.go:171","msg":"trace[273370794] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:964; }","duration":"186.024569ms","start":"2026-03-30T17:55:56.467488Z","end":"2026-03-30T17:55:56.653512Z","steps":["trace[273370794] 'agreement among raft nodes before linearized reading' (duration: 185.830114ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:56.653499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.663921ms","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-03-30T17:55:56.653326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.362425ms","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-03-30T17:55:56.653592Z","caller":"traceutil/trace.go:171","msg":"trace[74372356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:964; }","duration":"115.790613ms","start":"2026-03-30T17:55:56.537778Z","end":"2026-03-30T17:55:56.653569Z","steps":["trace[74372356] 'agreement among raft nodes before linearized reading' (duration: 115.506007ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:56.653644Z","caller":"traceutil/trace.go:171","msg":"trace[1683897067] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:964; }","duration":"457.719953ms","start":"2026-03-30T17:55:56.195895Z","end":"2026-03-30T17:55:56.653615Z","steps":["trace[1683897067] 'agreement among raft nodes before linearized reading' (duration: 457.312124ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:56.653327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.391719ms","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-03-30T17:55:56.653716Z","caller":"traceutil/trace.go:171","msg":"trace[1897234641] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:964; }","duration":"402.822218ms","start":"2026-03-30T17:55:56.250879Z","end":"2026-03-30T17:55:56.653702Z","steps":["trace[1897234641] 'agreement among raft nodes before linearized reading' (duration: 402.367218ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:56.6537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:56.195872Z","time spent":"457.812545ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-30T17:55:56.653747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:56.250859Z","time spent":"402.8781ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-30T17:55:56.653433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.852435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:55:56.653813Z","caller":"traceutil/trace.go:171","msg":"trace[1213343270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:964; }","duration":"209.272933ms","start":"2026-03-30T17:55:56.444532Z","end":"2026-03-30T17:55:56.653805Z","steps":["trace[1213343270] 'agreement among raft nodes before linearized reading' (duration: 208.798253ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:56.653958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.609352ms","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-03-30T17:55:56.653982Z","caller":"traceutil/trace.go:171","msg":"trace[2057194562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:964; }","duration":"135.659293ms","start":"2026-03-30T17:55:56.518315Z","end":"2026-03-30T17:55:56.653975Z","steps":["trace[2057194562] 'agreement among raft nodes before linearized reading' (duration: 134.940527ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:56.654135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:55.442935Z","time spent":"1.210604731s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:55:57.451366Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492927053076965,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:55:57.951918Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492927053076965,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:55:58.452299Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492927053076965,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:55:58.601709Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.944486629s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T17:55:58.602152Z","caller":"traceutil/trace.go:171","msg":"trace[88158313] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"1.94500614s","start":"2026-03-30T17:55:56.657129Z","end":"2026-03-30T17:55:58.602135Z","steps":["trace[88158313] 'process raft request' (duration: 1.944863396s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:58.60229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:56.657107Z","time spent":"1.945084802s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:55:58.60235Z","caller":"traceutil/trace.go:171","msg":"trace[1775618048] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"1.945187414s","start":"2026-03-30T17:55:56.657128Z","end":"2026-03-30T17:55:58.602316Z","steps":["trace[1775618048] 'process raft request' (duration: 1.944977539s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:58.602529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:56.657107Z","time spent":"1.945319458s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:55:58.631536Z","caller":"traceutil/trace.go:171","msg":"trace[1641446797] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"1.974129165s","start":"2026-03-30T17:55:56.65739Z","end":"2026-03-30T17:55:58.631519Z","steps":["trace[1641446797] 'process raft request' (duration: 1.973998443s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:58.631638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:56.65738Z","time spent":"1.974208767s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:55:58.631745Z","caller":"traceutil/trace.go:171","msg":"trace[513618573] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"1.973074211s","start":"2026-03-30T17:55:56.658647Z","end":"2026-03-30T17:55:58.631721Z","steps":["trace[513618573] 'process raft request' (duration: 1.972825805s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:58.63179Z","caller":"traceutil/trace.go:171","msg":"trace[1800700658] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"1.972328775s","start":"2026-03-30T17:55:56.659445Z","end":"2026-03-30T17:55:58.631773Z","steps":["trace[1800700658] 'process raft request' (duration: 1.972210382s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:55:58.631836Z","caller":"traceutil/trace.go:171","msg":"trace[288346809] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:998; }","duration":"1.681396304s","start":"2026-03-30T17:55:56.950432Z","end":"2026-03-30T17:55:58.631828Z","steps":["trace[288346809] 'read index received' (duration: 1.651538853s)","trace[288346809] 'applied index is now lower than readState.Index' (duration: 29.856651ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:55:58.631872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:56.658635Z","time spent":"1.973168914s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:55:58.631898Z","caller":"traceutil/trace.go:171","msg":"trace[299426928] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"1.172774635s","start":"2026-03-30T17:55:57.459118Z","end":"2026-03-30T17:55:58.631893Z","steps":["trace[299426928] 'process raft request' (duration: 1.172624601s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:58.631914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:56.659437Z","time spent":"1.972415677s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:55:58.631936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:57.459091Z","time spent":"1.172821485s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:55:58.631959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.571319407s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:55:58.63205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.681618309s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.133\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-30T17:55:58.632072Z","caller":"traceutil/trace.go:171","msg":"trace[15531831] range","detail":"{range_begin:/registry/masterleases/199.19.213.133; range_end:; response_count:1; response_revision:970; }","duration":"1.681668299s","start":"2026-03-30T17:55:56.950399Z","end":"2026-03-30T17:55:58.632067Z","steps":["trace[15531831] 'agreement among raft nodes before linearized reading' (duration: 1.681586508s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:58.632086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:56.950383Z","time spent":"1.681699841s","remote":"127.0.0.1:60034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.133\" "} {"level":"info","ts":"2026-03-30T17:55:58.632133Z","caller":"traceutil/trace.go:171","msg":"trace[981579644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:970; }","duration":"1.57145055s","start":"2026-03-30T17:55:57.060602Z","end":"2026-03-30T17:55:58.632053Z","steps":["trace[981579644] 'agreement among raft nodes before linearized reading' (duration: 1.571326407s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:55:58.632212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:55:57.060559Z","time spent":"1.571644154s","remote":"127.0.0.1:50254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T17:55:58.632194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.661724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-30T17:55:58.63228Z","caller":"traceutil/trace.go:171","msg":"trace[179396960] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:970; }","duration":"252.777186ms","start":"2026-03-30T17:55:58.379486Z","end":"2026-03-30T17:55:58.632263Z","steps":["trace[179396960] 'agreement among raft nodes before linearized reading' (duration: 252.51437ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:18.871164Z","caller":"traceutil/trace.go:171","msg":"trace[1620627684] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"154.05304ms","start":"2026-03-30T17:56:18.717081Z","end":"2026-03-30T17:56:18.871134Z","steps":["trace[1620627684] 'process raft request' (duration: 153.907237ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:19.402086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.995893ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T17:56:19.402182Z","caller":"traceutil/trace.go:171","msg":"trace[582414800] linearizableReadLoop","detail":"{readStateIndex:1072; appliedIndex:1071; }","duration":"674.733527ms","start":"2026-03-30T17:56:18.727436Z","end":"2026-03-30T17:56:19.402169Z","steps":["trace[582414800] 'read index received' (duration: 143.870345ms)","trace[582414800] 'applied index is now lower than readState.Index' (duration: 530.862002ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:56:19.402252Z","caller":"traceutil/trace.go:171","msg":"trace[121209977] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"682.10882ms","start":"2026-03-30T17:56:18.720078Z","end":"2026-03-30T17:56:19.402187Z","steps":["trace[121209977] 'process raft request' (duration: 334.944614ms)","trace[121209977] 'compare' (duration: 346.8494ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:56:19.402326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.89841ms","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-03-30T17:56:19.402348Z","caller":"traceutil/trace.go:171","msg":"trace[984332241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1033; }","duration":"674.940552ms","start":"2026-03-30T17:56:18.727401Z","end":"2026-03-30T17:56:19.402342Z","steps":["trace[984332241] 'agreement among raft nodes before linearized reading' (duration: 674.829739ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:19.402376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:18.727393Z","time spent":"674.978032ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-30T17:56:19.402465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:18.720061Z","time spent":"682.286475ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:56:19.475707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.615079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-30T17:56:19.475787Z","caller":"traceutil/trace.go:171","msg":"trace[456814515] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1034; }","duration":"573.751432ms","start":"2026-03-30T17:56:18.902018Z","end":"2026-03-30T17:56:19.475769Z","steps":["trace[456814515] 'agreement among raft nodes before linearized reading' (duration: 573.576118ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:19.475803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.63566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:56:19.475838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:18.901988Z","time spent":"573.834814ms","remote":"127.0.0.1:37382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-03-30T17:56:19.475848Z","caller":"traceutil/trace.go:171","msg":"trace[718541080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1034; }","duration":"414.728092ms","start":"2026-03-30T17:56:19.061108Z","end":"2026-03-30T17:56:19.475836Z","steps":["trace[718541080] 'agreement among raft nodes before linearized reading' (duration: 414.65106ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:19.475901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:19.061084Z","time spent":"414.802733ms","remote":"127.0.0.1:50238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T17:56:19.475695Z","caller":"traceutil/trace.go:171","msg":"trace[87813811] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"424.176831ms","start":"2026-03-30T17:56:19.051462Z","end":"2026-03-30T17:56:19.475639Z","steps":["trace[87813811] 'process raft request' (duration: 423.887875ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:19.475989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.424603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-03-30T17:56:19.475998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.455385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-30T17:56:19.476026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.211935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-30T17:56:19.476029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:19.051432Z","time spent":"424.525429ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:56:19.476048Z","caller":"traceutil/trace.go:171","msg":"trace[1776820261] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1034; }","duration":"722.521856ms","start":"2026-03-30T17:56:18.753512Z","end":"2026-03-30T17:56:19.476034Z","steps":["trace[1776820261] 'agreement among raft nodes before linearized reading' (duration: 722.328172ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:19.476068Z","caller":"traceutil/trace.go:171","msg":"trace[1685223657] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1034; }","duration":"643.574188ms","start":"2026-03-30T17:56:18.832477Z","end":"2026-03-30T17:56:19.476051Z","steps":["trace[1685223657] 'agreement among raft nodes before linearized reading' (duration: 643.422805ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:19.476088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:18.753501Z","time spent":"722.581847ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-03-30T17:56:19.476088Z","caller":"traceutil/trace.go:171","msg":"trace[236674518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1034; }","duration":"725.304528ms","start":"2026-03-30T17:56:18.750766Z","end":"2026-03-30T17:56:19.476071Z","steps":["trace[236674518] 'agreement among raft nodes before linearized reading' (duration: 725.106564ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:19.476108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:18.832464Z","time spent":"643.636259ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:56:19.476137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:18.750753Z","time spent":"725.374069ms","remote":"127.0.0.1:60258","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-03-30T17:56:19.476594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.039947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-30T17:56:19.476662Z","caller":"traceutil/trace.go:171","msg":"trace[73543699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1034; }","duration":"741.127908ms","start":"2026-03-30T17:56:18.735515Z","end":"2026-03-30T17:56:19.476643Z","steps":["trace[73543699] 'agreement among raft nodes before linearized reading' (duration: 740.042495ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:19.47671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:18.735504Z","time spent":"741.19533ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-30T17:56:19.621567Z","caller":"traceutil/trace.go:171","msg":"trace[2052960515] linearizableReadLoop","detail":"{readStateIndex:1074; appliedIndex:1073; }","duration":"143.771023ms","start":"2026-03-30T17:56:19.477769Z","end":"2026-03-30T17:56:19.62154Z","steps":["trace[2052960515] 'read index received' (duration: 116.120591ms)","trace[2052960515] 'applied index is now lower than readState.Index' (duration: 27.649442ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:56:19.621718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.916456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:56:19.621803Z","caller":"traceutil/trace.go:171","msg":"trace[2044063838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1035; }","duration":"144.0455ms","start":"2026-03-30T17:56:19.477738Z","end":"2026-03-30T17:56:19.621784Z","steps":["trace[2044063838] 'agreement among raft nodes before linearized reading' (duration: 143.894716ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:19.622221Z","caller":"traceutil/trace.go:171","msg":"trace[1713088762] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"215.389789ms","start":"2026-03-30T17:56:19.4068Z","end":"2026-03-30T17:56:19.622189Z","steps":["trace[1713088762] 'process raft request' (duration: 187.096932ms)","trace[1713088762] 'compare' (duration: 27.5255ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:56:19.629707Z","caller":"traceutil/trace.go:171","msg":"trace[1146191252] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"148.818695ms","start":"2026-03-30T17:56:19.48087Z","end":"2026-03-30T17:56:19.629688Z","steps":["trace[1146191252] 'process raft request' (duration: 148.747393ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:19.629833Z","caller":"traceutil/trace.go:171","msg":"trace[1241557698] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"150.186505ms","start":"2026-03-30T17:56:19.47964Z","end":"2026-03-30T17:56:19.629826Z","steps":["trace[1241557698] 'process raft request' (duration: 149.886469ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:19.630014Z","caller":"traceutil/trace.go:171","msg":"trace[720892994] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"149.04753ms","start":"2026-03-30T17:56:19.480956Z","end":"2026-03-30T17:56:19.630003Z","steps":["trace[720892994] 'process raft request' (duration: 148.698442ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:22.126627Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492927053077170,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:56:22.59486Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.513022726s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T17:56:22.595149Z","caller":"traceutil/trace.go:171","msg":"trace[1262009078] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"1.513417954s","start":"2026-03-30T17:56:21.081711Z","end":"2026-03-30T17:56:22.595129Z","steps":["trace[1262009078] 'process raft request' (duration: 1.513308322s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:22.59527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:21.081684Z","time spent":"1.513525547s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:56:22.60308Z","caller":"traceutil/trace.go:171","msg":"trace[1675651721] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"1.193915981s","start":"2026-03-30T17:56:21.409145Z","end":"2026-03-30T17:56:22.603061Z","steps":["trace[1675651721] 'process raft request' (duration: 1.193770838s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:22.603199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:21.409118Z","time spent":"1.194007873s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:56:22.621337Z","caller":"traceutil/trace.go:171","msg":"trace[1327691632] linearizableReadLoop","detail":"{readStateIndex:1080; appliedIndex:1078; }","duration":"995.414047ms","start":"2026-03-30T17:56:21.625899Z","end":"2026-03-30T17:56:22.621313Z","steps":["trace[1327691632] 'read index received' (duration: 969.159836ms)","trace[1327691632] 'applied index is now lower than readState.Index' (duration: 26.252881ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:56:22.621544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.739441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:56:22.621625Z","caller":"traceutil/trace.go:171","msg":"trace[204390294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1041; }","duration":"512.860884ms","start":"2026-03-30T17:56:22.108751Z","end":"2026-03-30T17:56:22.621612Z","steps":["trace[204390294] 'agreement among raft nodes before linearized reading' (duration: 512.745581ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:22.621617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.211146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-30T17:56:22.621659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:22.108732Z","time spent":"512.919466ms","remote":"127.0.0.1:50238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T17:56:22.621661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"995.713744ms","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-03-30T17:56:22.621681Z","caller":"traceutil/trace.go:171","msg":"trace[850564031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1041; }","duration":"987.310848ms","start":"2026-03-30T17:56:21.634356Z","end":"2026-03-30T17:56:22.621667Z","steps":["trace[850564031] 'agreement among raft nodes before linearized reading' (duration: 987.112654ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:22.621693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.278354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-30T17:56:22.621735Z","caller":"traceutil/trace.go:171","msg":"trace[1120612084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1041; }","duration":"995.833667ms","start":"2026-03-30T17:56:21.625857Z","end":"2026-03-30T17:56:22.62169Z","steps":["trace[1120612084] 'agreement among raft nodes before linearized reading' (duration: 995.579841ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:22.621748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.319838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-30T17:56:22.621814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:21.62584Z","time spent":"995.961779ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-30T17:56:22.621764Z","caller":"traceutil/trace.go:171","msg":"trace[1545528339] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1041; }","duration":"986.363537ms","start":"2026-03-30T17:56:21.63538Z","end":"2026-03-30T17:56:22.621743Z","steps":["trace[1545528339] 'agreement among raft nodes before linearized reading' (duration: 986.182333ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:22.622052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:21.635373Z","time spent":"986.662073ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-30T17:56:22.62196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.540362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-30T17:56:22.6222Z","caller":"traceutil/trace.go:171","msg":"trace[1216340643] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1041; }","duration":"715.878359ms","start":"2026-03-30T17:56:21.906295Z","end":"2026-03-30T17:56:22.622174Z","steps":["trace[1216340643] 'agreement among raft nodes before linearized reading' (duration: 715.302357ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:22.62227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:21.906269Z","time spent":"715.982881ms","remote":"127.0.0.1:60390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-03-30T17:56:22.621824Z","caller":"traceutil/trace.go:171","msg":"trace[1298233641] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1041; }","duration":"987.41064ms","start":"2026-03-30T17:56:21.634396Z","end":"2026-03-30T17:56:22.621807Z","steps":["trace[1298233641] 'agreement among raft nodes before linearized reading' (duration: 987.193895ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:22.622336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:21.634391Z","time spent":"987.928911ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-30T17:56:22.621715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:21.634346Z","time spent":"987.363459ms","remote":"127.0.0.1:60258","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-03-30T17:56:24.817777Z","caller":"traceutil/trace.go:171","msg":"trace[1985857336] linearizableReadLoop","detail":"{readStateIndex:1087; appliedIndex:1086; }","duration":"160.31508ms","start":"2026-03-30T17:56:24.65744Z","end":"2026-03-30T17:56:24.817755Z","steps":["trace[1985857336] 'read index received' (duration: 160.111405ms)","trace[1985857336] 'applied index is now lower than readState.Index' (duration: 202.785µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:56:24.81804Z","caller":"traceutil/trace.go:171","msg":"trace[1313878530] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"209.530929ms","start":"2026-03-30T17:56:24.608496Z","end":"2026-03-30T17:56:24.818027Z","steps":["trace[1313878530] 'process raft request' (duration: 209.13729ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:24.818287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.846191ms","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-03-30T17:56:24.818326Z","caller":"traceutil/trace.go:171","msg":"trace[662061900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1047; }","duration":"160.936333ms","start":"2026-03-30T17:56:24.657381Z","end":"2026-03-30T17:56:24.818317Z","steps":["trace[662061900] 'agreement among raft nodes before linearized reading' (duration: 160.81131ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:24.818444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.01677ms","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-03-30T17:56:24.818467Z","caller":"traceutil/trace.go:171","msg":"trace[1318471104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1047; }","duration":"140.059931ms","start":"2026-03-30T17:56:24.6784Z","end":"2026-03-30T17:56:24.81846Z","steps":["trace[1318471104] 'agreement among raft nodes before linearized reading' (duration: 139.99173ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:24.818453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.680833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-30T17:56:24.81851Z","caller":"traceutil/trace.go:171","msg":"trace[1268308854] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1047; }","duration":"139.757404ms","start":"2026-03-30T17:56:24.678737Z","end":"2026-03-30T17:56:24.818495Z","steps":["trace[1268308854] 'agreement among raft nodes before linearized reading' (duration: 139.608821ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:24.818577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.415069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-30T17:56:24.819Z","caller":"traceutil/trace.go:171","msg":"trace[554740226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1047; }","duration":"140.979871ms","start":"2026-03-30T17:56:24.677994Z","end":"2026-03-30T17:56:24.818974Z","steps":["trace[554740226] 'agreement among raft nodes before linearized reading' (duration: 140.289626ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:25.214681Z","caller":"traceutil/trace.go:171","msg":"trace[1884766473] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"141.396199ms","start":"2026-03-30T17:56:25.073244Z","end":"2026-03-30T17:56:25.21464Z","steps":["trace[1884766473] 'process raft request' (duration: 141.240996ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:27.005402Z","caller":"traceutil/trace.go:171","msg":"trace[1215971478] linearizableReadLoop","detail":"{readStateIndex:1093; appliedIndex:1092; }","duration":"138.514218ms","start":"2026-03-30T17:56:26.866868Z","end":"2026-03-30T17:56:27.005382Z","steps":["trace[1215971478] 'read index received' (duration: 138.365234ms)","trace[1215971478] 'applied index is now lower than readState.Index' (duration: 148.104µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:56:27.005635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.747143ms","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-03-30T17:56:27.005704Z","caller":"traceutil/trace.go:171","msg":"trace[475737348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1053; }","duration":"138.879986ms","start":"2026-03-30T17:56:26.866809Z","end":"2026-03-30T17:56:27.005689Z","steps":["trace[475737348] 'agreement among raft nodes before linearized reading' (duration: 138.649601ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:27.005775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.089009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-03-30T17:56:27.005809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.799256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-30T17:56:27.005836Z","caller":"traceutil/trace.go:171","msg":"trace[1932744837] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1053; }","duration":"124.19358ms","start":"2026-03-30T17:56:26.881626Z","end":"2026-03-30T17:56:27.00582Z","steps":["trace[1932744837] 'agreement among raft nodes before linearized reading' (duration: 124.016017ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:27.005854Z","caller":"traceutil/trace.go:171","msg":"trace[120465970] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1053; }","duration":"125.868337ms","start":"2026-03-30T17:56:26.879974Z","end":"2026-03-30T17:56:27.005842Z","steps":["trace[120465970] 'agreement among raft nodes before linearized reading' (duration: 125.735354ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:27.006696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.248677ms","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-03-30T17:56:27.006808Z","caller":"traceutil/trace.go:171","msg":"trace[588931399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1053; }","duration":"127.430601ms","start":"2026-03-30T17:56:26.879354Z","end":"2026-03-30T17:56:27.006784Z","steps":["trace[588931399] 'agreement among raft nodes before linearized reading' (duration: 126.284876ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:27.007346Z","caller":"traceutil/trace.go:171","msg":"trace[1291541528] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"139.377226ms","start":"2026-03-30T17:56:26.866073Z","end":"2026-03-30T17:56:27.005451Z","steps":["trace[1291541528] 'process raft request' (duration: 139.187511ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:27.299292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.109012ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-03-30T17:56:27.368816Z","caller":"traceutil/trace.go:171","msg":"trace[570898541] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"358.437665ms","start":"2026-03-30T17:56:27.010353Z","end":"2026-03-30T17:56:27.368791Z","steps":["trace[570898541] 'process raft request' (duration: 358.264552ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:27.368911Z","caller":"traceutil/trace.go:171","msg":"trace[1450988830] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"357.940454ms","start":"2026-03-30T17:56:27.010939Z","end":"2026-03-30T17:56:27.368879Z","steps":["trace[1450988830] 'process raft request' (duration: 357.844062ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:27.369038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.183844ms","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-03-30T17:56:27.369078Z","caller":"traceutil/trace.go:171","msg":"trace[1106140206] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1057; }","duration":"150.298766ms","start":"2026-03-30T17:56:27.218771Z","end":"2026-03-30T17:56:27.36907Z","steps":["trace[1106140206] 'agreement among raft nodes before linearized reading' (duration: 150.107992ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:27.368856Z","caller":"traceutil/trace.go:171","msg":"trace[1153799523] linearizableReadLoop","detail":"{readStateIndex:1098; appliedIndex:1094; }","duration":"150.032061ms","start":"2026-03-30T17:56:27.218811Z","end":"2026-03-30T17:56:27.368843Z","steps":["trace[1153799523] 'read index received' (duration: 149.843566ms)","trace[1153799523] 'applied index is now lower than readState.Index' (duration: 187.554µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:56:27.369111Z","caller":"traceutil/trace.go:171","msg":"trace[1490276202] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"358.280712ms","start":"2026-03-30T17:56:27.010823Z","end":"2026-03-30T17:56:27.369104Z","steps":["trace[1490276202] 'process raft request' (duration: 357.927205ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:27.369106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:27.010914Z","time spent":"358.070168ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:56:27.369165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:27.010814Z","time spent":"358.313873ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:56:27.368985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:27.010331Z","time spent":"358.567209ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:56:27.369233Z","caller":"traceutil/trace.go:171","msg":"trace[1340283787] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"358.038576ms","start":"2026-03-30T17:56:27.011083Z","end":"2026-03-30T17:56:27.369121Z","steps":["trace[1340283787] 'process raft request' (duration: 357.728509ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:27.369525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:27.011074Z","time spent":"358.301821ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:56:27.42454Z","caller":"traceutil/trace.go:171","msg":"trace[1269609668] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"123.643948ms","start":"2026-03-30T17:56:27.300875Z","end":"2026-03-30T17:56:27.424519Z","steps":["trace[1269609668] 'process raft request' (duration: 115.888705ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:37.530905Z","caller":"traceutil/trace.go:171","msg":"trace[185109354] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"108.153541ms","start":"2026-03-30T17:56:37.422727Z","end":"2026-03-30T17:56:37.53088Z","steps":["trace[185109354] 'process raft request' (duration: 108.028428ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:37.5377Z","caller":"traceutil/trace.go:171","msg":"trace[2098887836] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"114.671815ms","start":"2026-03-30T17:56:37.422983Z","end":"2026-03-30T17:56:37.537655Z","steps":["trace[2098887836] 'process raft request' (duration: 114.339868ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:37.537978Z","caller":"traceutil/trace.go:171","msg":"trace[1123678142] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"114.070811ms","start":"2026-03-30T17:56:37.423886Z","end":"2026-03-30T17:56:37.537957Z","steps":["trace[1123678142] 'process raft request' (duration: 113.617211ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:37.538106Z","caller":"traceutil/trace.go:171","msg":"trace[500339269] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"113.511849ms","start":"2026-03-30T17:56:37.424581Z","end":"2026-03-30T17:56:37.538093Z","steps":["trace[500339269] 'process raft request' (duration: 113.11101ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:40.042979Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492927053077405,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:56:40.54352Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492927053077405,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:56:40.713908Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.175946495s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T17:56:40.714246Z","caller":"traceutil/trace.go:171","msg":"trace[9422593] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"1.176331304s","start":"2026-03-30T17:56:39.537889Z","end":"2026-03-30T17:56:40.71422Z","steps":["trace[9422593] 'process raft request' (duration: 1.176199651s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:40.714412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:39.537871Z","time spent":"1.176460496s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:56:41.13399Z","caller":"traceutil/trace.go:171","msg":"trace[1853637100] linearizableReadLoop","detail":"{readStateIndex:1191; appliedIndex:1189; }","duration":"1.591689405s","start":"2026-03-30T17:56:39.542278Z","end":"2026-03-30T17:56:41.133968Z","steps":["trace[1853637100] 'read index received' (duration: 1.171836324s)","trace[1853637100] 'applied index is now lower than readState.Index' (duration: 419.851891ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:56:41.134162Z","caller":"traceutil/trace.go:171","msg":"trace[1170388036] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"1.175922475s","start":"2026-03-30T17:56:39.958183Z","end":"2026-03-30T17:56:41.134105Z","steps":["trace[1170388036] 'process raft request' (duration: 1.175314992s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:41.134204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.59190087s","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-03-30T17:56:41.134341Z","caller":"traceutil/trace.go:171","msg":"trace[1610392950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1146; }","duration":"1.592065854s","start":"2026-03-30T17:56:39.542262Z","end":"2026-03-30T17:56:41.134327Z","steps":["trace[1610392950] 'agreement among raft nodes before linearized reading' (duration: 1.591819119s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:41.134386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:39.958157Z","time spent":"1.17610698s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:56:41.13439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:39.542254Z","time spent":"1.592114665s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-30T17:56:41.199828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099779641s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:56:41.199903Z","caller":"traceutil/trace.go:171","msg":"trace[846433494] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1147; }","duration":"1.099927405s","start":"2026-03-30T17:56:40.099959Z","end":"2026-03-30T17:56:41.199886Z","steps":["trace[846433494] 'agreement among raft nodes before linearized reading' (duration: 1.099765231s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:41.199954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:40.099934Z","time spent":"1.100014587s","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:56:41.199984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.724713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:56:41.200054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.278212497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:56:41.200068Z","caller":"traceutil/trace.go:171","msg":"trace[816925144] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1147; }","duration":"141.851446ms","start":"2026-03-30T17:56:41.058191Z","end":"2026-03-30T17:56:41.200043Z","steps":["trace[816925144] 'agreement among raft nodes before linearized reading' (duration: 141.682861ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:41.200105Z","caller":"traceutil/trace.go:171","msg":"trace[596843624] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1147; }","duration":"1.278313409s","start":"2026-03-30T17:56:39.921777Z","end":"2026-03-30T17:56:41.20009Z","steps":["trace[596843624] 'agreement among raft nodes before linearized reading' (duration: 1.278215747s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:41.200144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:39.921757Z","time spent":"1.27837632s","remote":"127.0.0.1:33362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:56:41.200136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.653079094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-30T17:56:41.200165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.65653437s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-30T17:56:41.200254Z","caller":"traceutil/trace.go:171","msg":"trace[925823867] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1147; }","duration":"1.653237667s","start":"2026-03-30T17:56:39.546985Z","end":"2026-03-30T17:56:41.200222Z","steps":["trace[925823867] 'agreement among raft nodes before linearized reading' (duration: 1.652814317s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:41.200259Z","caller":"traceutil/trace.go:171","msg":"trace[1282594478] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1147; }","duration":"1.656682773s","start":"2026-03-30T17:56:39.543554Z","end":"2026-03-30T17:56:41.200237Z","steps":["trace[1282594478] 'agreement among raft nodes before linearized reading' (duration: 1.656352266s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:41.200315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:39.546978Z","time spent":"1.653327119s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-30T17:56:41.200377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:39.543535Z","time spent":"1.656773865s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-30T17:56:41.201075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.658246507s","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-03-30T17:56:41.201274Z","caller":"traceutil/trace.go:171","msg":"trace[469434285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1147; }","duration":"1.658534293s","start":"2026-03-30T17:56:39.542713Z","end":"2026-03-30T17:56:41.201247Z","steps":["trace[469434285] 'agreement among raft nodes before linearized reading' (duration: 1.656958658s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:41.201446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:39.542697Z","time spent":"1.658732457s","remote":"127.0.0.1:60258","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-03-30T17:56:41.201138Z","caller":"traceutil/trace.go:171","msg":"trace[1525712991] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"147.968771ms","start":"2026-03-30T17:56:41.05309Z","end":"2026-03-30T17:56:41.201059Z","steps":["trace[1525712991] 'process raft request' (duration: 146.477418ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:53.206797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.718523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-30T17:56:53.206882Z","caller":"traceutil/trace.go:171","msg":"trace[339698250] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1185; }","duration":"198.836736ms","start":"2026-03-30T17:56:53.008025Z","end":"2026-03-30T17:56:53.206862Z","steps":["trace[339698250] 'count revisions from in-memory index tree' (duration: 198.625531ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:55.376807Z","caller":"traceutil/trace.go:171","msg":"trace[256239350] linearizableReadLoop","detail":"{readStateIndex:1250; appliedIndex:1248; }","duration":"112.951496ms","start":"2026-03-30T17:56:55.263835Z","end":"2026-03-30T17:56:55.376787Z","steps":["trace[256239350] 'read index received' (duration: 76.605853ms)","trace[256239350] 'applied index is now lower than readState.Index' (duration: 36.344483ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:56:55.377156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.285064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-03-30T17:56:55.377193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.605288ms","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-03-30T17:56:55.377299Z","caller":"traceutil/trace.go:171","msg":"trace[1011471077] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"114.078243ms","start":"2026-03-30T17:56:55.262763Z","end":"2026-03-30T17:56:55.376841Z","steps":["trace[1011471077] 'process raft request' (duration: 113.917069ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:55.377349Z","caller":"traceutil/trace.go:171","msg":"trace[1278272305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1202; }","duration":"111.894733ms","start":"2026-03-30T17:56:55.265438Z","end":"2026-03-30T17:56:55.377333Z","steps":["trace[1278272305] 'agreement among raft nodes before linearized reading' (duration: 111.468714ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:55.377238Z","caller":"traceutil/trace.go:171","msg":"trace[812645093] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1202; }","duration":"113.435147ms","start":"2026-03-30T17:56:55.263786Z","end":"2026-03-30T17:56:55.377221Z","steps":["trace[812645093] 'agreement among raft nodes before linearized reading' (duration: 113.11355ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:57.246867Z","caller":"traceutil/trace.go:171","msg":"trace[980400750] linearizableReadLoop","detail":"{readStateIndex:1255; appliedIndex:1254; }","duration":"293.610691ms","start":"2026-03-30T17:56:56.953224Z","end":"2026-03-30T17:56:57.246835Z","steps":["trace[980400750] 'read index received' (duration: 293.189641ms)","trace[980400750] 'applied index is now lower than readState.Index' (duration: 419.42µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:56:57.247008Z","caller":"traceutil/trace.go:171","msg":"trace[319724394] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"366.219995ms","start":"2026-03-30T17:56:56.880739Z","end":"2026-03-30T17:56:57.246959Z","steps":["trace[319724394] 'process raft request' (duration: 365.863518ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:57.247156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.90332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:56:57.247192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.944408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.133\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-30T17:56:57.247218Z","caller":"traceutil/trace.go:171","msg":"trace[669305634] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1207; }","duration":"186.002992ms","start":"2026-03-30T17:56:57.0612Z","end":"2026-03-30T17:56:57.247203Z","steps":["trace[669305634] 'agreement among raft nodes before linearized reading' (duration: 185.875029ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:57.247235Z","caller":"traceutil/trace.go:171","msg":"trace[664598772] range","detail":"{range_begin:/registry/masterleases/199.19.213.133; range_end:; response_count:1; response_revision:1207; }","duration":"294.05232ms","start":"2026-03-30T17:56:56.953171Z","end":"2026-03-30T17:56:57.247223Z","steps":["trace[664598772] 'agreement among raft nodes before linearized reading' (duration: 293.843756ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:57.247251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:56.880722Z","time spent":"366.40199ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:56:57.58071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.587984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T17:56:57.580823Z","caller":"traceutil/trace.go:171","msg":"trace[1165475500] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"159.69182ms","start":"2026-03-30T17:56:57.421115Z","end":"2026-03-30T17:56:57.580807Z","steps":["trace[1165475500] 'process raft request' (duration: 53.923542ms)","trace[1165475500] 'compare' (duration: 105.38062ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:56:57.599105Z","caller":"traceutil/trace.go:171","msg":"trace[1031002758] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"176.184583ms","start":"2026-03-30T17:56:57.422886Z","end":"2026-03-30T17:56:57.599071Z","steps":["trace[1031002758] 'process raft request' (duration: 176.098752ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:57.599168Z","caller":"traceutil/trace.go:171","msg":"trace[1309222598] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"177.80088ms","start":"2026-03-30T17:56:57.421295Z","end":"2026-03-30T17:56:57.599095Z","steps":["trace[1309222598] 'process raft request' (duration: 177.499833ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:59.204451Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.073661085s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T17:56:59.204771Z","caller":"traceutil/trace.go:171","msg":"trace[180503574] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1263; }","duration":"369.228232ms","start":"2026-03-30T17:56:58.835521Z","end":"2026-03-30T17:56:59.20475Z","steps":["trace[180503574] 'read index received' (duration: 369.048308ms)","trace[180503574] 'applied index is now lower than readState.Index' (duration: 179.194µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:56:59.205031Z","caller":"traceutil/trace.go:171","msg":"trace[2004689903] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"1.07433072s","start":"2026-03-30T17:56:58.13069Z","end":"2026-03-30T17:56:59.205021Z","steps":["trace[2004689903] 'process raft request' (duration: 1.073936321s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:59.205119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:58.130674Z","time spent":"1.07437996s","remote":"127.0.0.1:60166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:56:59.205361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.817885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-30T17:56:59.205398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.159588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:56:59.205427Z","caller":"traceutil/trace.go:171","msg":"trace[1640797608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1215; }","duration":"144.220878ms","start":"2026-03-30T17:56:59.061197Z","end":"2026-03-30T17:56:59.205418Z","steps":["trace[1640797608] 'agreement among raft nodes before linearized reading' (duration: 144.169227ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:56:59.205424Z","caller":"traceutil/trace.go:171","msg":"trace[1794456554] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1215; }","duration":"369.961348ms","start":"2026-03-30T17:56:58.835449Z","end":"2026-03-30T17:56:59.20541Z","steps":["trace[1794456554] 'agreement among raft nodes before linearized reading' (duration: 369.817025ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:56:59.205462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:58.835394Z","time spent":"370.06031ms","remote":"127.0.0.1:60452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:56:59.710564Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492927053077566,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-30T17:57:00.116136Z","caller":"traceutil/trace.go:171","msg":"trace[1222819402] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"906.11563ms","start":"2026-03-30T17:56:59.209996Z","end":"2026-03-30T17:57:00.116111Z","steps":["trace[1222819402] 'process raft request' (duration: 905.884255ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:00.116249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:59.209977Z","time spent":"906.213952ms","remote":"127.0.0.1:60070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":757,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-30T17:57:00.163252Z","caller":"traceutil/trace.go:171","msg":"trace[638664998] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"948.563819ms","start":"2026-03-30T17:56:59.214663Z","end":"2026-03-30T17:57:00.163227Z","steps":["trace[638664998] 'process raft request' (duration: 948.383175ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:00.163413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:59.21464Z","time spent":"948.693302ms","remote":"127.0.0.1:60390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":797,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:57:00.16347Z","caller":"traceutil/trace.go:171","msg":"trace[306925398] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"776.668219ms","start":"2026-03-30T17:56:59.386784Z","end":"2026-03-30T17:57:00.163452Z","steps":["trace[306925398] 'process raft request' (duration: 776.379663ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:00.163411Z","caller":"traceutil/trace.go:171","msg":"trace[283117132] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1264; }","duration":"953.212091ms","start":"2026-03-30T17:56:59.210172Z","end":"2026-03-30T17:57:00.163384Z","steps":["trace[283117132] 'read index received' (duration: 905.909365ms)","trace[283117132] 'applied index is now lower than readState.Index' (duration: 47.294496ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:57:00.163521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.322704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:57:00.163564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:59.386764Z","time spent":"776.750691ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:57:00.163584Z","caller":"traceutil/trace.go:171","msg":"trace[647522621] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1218; }","duration":"953.420745ms","start":"2026-03-30T17:56:59.210152Z","end":"2026-03-30T17:57:00.163573Z","steps":["trace[647522621] 'agreement among raft nodes before linearized reading' (duration: 953.303593ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:00.163619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:59.210142Z","time spent":"953.468307ms","remote":"127.0.0.1:50254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-30T17:57:00.426606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.828314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-30T17:57:00.426719Z","caller":"traceutil/trace.go:171","msg":"trace[450845740] linearizableReadLoop","detail":"{readStateIndex:1268; appliedIndex:1267; }","duration":"263.124496ms","start":"2026-03-30T17:57:00.163578Z","end":"2026-03-30T17:57:00.426702Z","steps":["trace[450845740] 'read index received' (duration: 141.056427ms)","trace[450845740] 'applied index is now lower than readState.Index' (duration: 122.066259ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:57:00.426799Z","caller":"traceutil/trace.go:171","msg":"trace[1354674200] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"307.358305ms","start":"2026-03-30T17:57:00.11943Z","end":"2026-03-30T17:57:00.426788Z","steps":["trace[1354674200] 'process raft request' (duration: 185.263765ms)","trace[1354674200] 'compare' (duration: 121.63047ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:57:00.426857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:00.119404Z","time spent":"307.429996ms","remote":"127.0.0.1:60070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":823,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T17:57:00.427165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.646536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-30T17:57:00.427213Z","caller":"traceutil/trace.go:171","msg":"trace[1907650892] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1219; }","duration":"547.734508ms","start":"2026-03-30T17:56:59.879469Z","end":"2026-03-30T17:57:00.427204Z","steps":["trace[1907650892] 'agreement among raft nodes before linearized reading' (duration: 547.564374ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:00.427246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:59.879449Z","time spent":"547.786499ms","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:57:00.427464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005406355s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-03-30T17:57:00.427477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.146032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:57:00.427509Z","caller":"traceutil/trace.go:171","msg":"trace[480809088] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1219; }","duration":"1.005473846s","start":"2026-03-30T17:56:59.422021Z","end":"2026-03-30T17:57:00.427495Z","steps":["trace[480809088] 'agreement among raft nodes before linearized reading' (duration: 1.005306363s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:00.427542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:59.422014Z","time spent":"1.005520748s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-03-30T17:57:00.427555Z","caller":"traceutil/trace.go:171","msg":"trace[1602708904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1219; }","duration":"256.277275ms","start":"2026-03-30T17:57:00.171252Z","end":"2026-03-30T17:57:00.427529Z","steps":["trace[1602708904] 'agreement among raft nodes before linearized reading' (duration: 256.136442ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:00.427562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156799382s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-30T17:57:00.427645Z","caller":"traceutil/trace.go:171","msg":"trace[211240440] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1219; }","duration":"1.156903104s","start":"2026-03-30T17:56:59.270711Z","end":"2026-03-30T17:57:00.427614Z","steps":["trace[211240440] 'agreement among raft nodes before linearized reading' (duration: 1.156637258s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:00.427685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:59.270703Z","time spent":"1.156973565s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-30T17:57:00.427721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.255121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-30T17:57:00.427749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.756272ms","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-03-30T17:57:00.427758Z","caller":"traceutil/trace.go:171","msg":"trace[1891854279] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1219; }","duration":"824.323802ms","start":"2026-03-30T17:56:59.603425Z","end":"2026-03-30T17:57:00.427749Z","steps":["trace[1891854279] 'agreement among raft nodes before linearized reading' (duration: 824.219129ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:00.427778Z","caller":"traceutil/trace.go:171","msg":"trace[369929695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1219; }","duration":"843.815703ms","start":"2026-03-30T17:56:59.583953Z","end":"2026-03-30T17:57:00.427769Z","steps":["trace[369929695] 'agreement among raft nodes before linearized reading' (duration: 843.731071ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:00.427785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:59.603406Z","time spent":"824.373383ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-30T17:57:00.427803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:59.583936Z","time spent":"843.861934ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-30T17:57:00.427899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.341183ms","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-03-30T17:57:00.427922Z","caller":"traceutil/trace.go:171","msg":"trace[1105691486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1219; }","duration":"824.399703ms","start":"2026-03-30T17:56:59.603515Z","end":"2026-03-30T17:57:00.427915Z","steps":["trace[1105691486] 'agreement among raft nodes before linearized reading' (duration: 824.331512ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:00.427945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:56:59.603496Z","time spent":"824.444635ms","remote":"127.0.0.1:60258","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-03-30T17:57:00.689082Z","caller":"traceutil/trace.go:171","msg":"trace[1991980706] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"255.643612ms","start":"2026-03-30T17:57:00.433415Z","end":"2026-03-30T17:57:00.689059Z","steps":["trace[1991980706] 'process raft request' (duration: 255.509368ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:00.689092Z","caller":"traceutil/trace.go:171","msg":"trace[1097209968] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"255.666702ms","start":"2026-03-30T17:57:00.433399Z","end":"2026-03-30T17:57:00.689066Z","steps":["trace[1097209968] 'process raft request' (duration: 255.324744ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:00.689276Z","caller":"traceutil/trace.go:171","msg":"trace[1214614715] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"255.785085ms","start":"2026-03-30T17:57:00.433476Z","end":"2026-03-30T17:57:00.689261Z","steps":["trace[1214614715] 'process raft request' (duration: 255.503938ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:00.689512Z","caller":"traceutil/trace.go:171","msg":"trace[990489829] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"255.991459ms","start":"2026-03-30T17:57:00.433506Z","end":"2026-03-30T17:57:00.689497Z","steps":["trace[990489829] 'process raft request' (duration: 255.680493ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:02.042443Z","caller":"traceutil/trace.go:171","msg":"trace[1076690466] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"240.989257ms","start":"2026-03-30T17:57:01.801434Z","end":"2026-03-30T17:57:02.042423Z","steps":["trace[1076690466] 'process raft request' (duration: 240.853054ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:02.504943Z","caller":"traceutil/trace.go:171","msg":"trace[713328678] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"336.746214ms","start":"2026-03-30T17:57:02.168172Z","end":"2026-03-30T17:57:02.504918Z","steps":["trace[713328678] 'process raft request' (duration: 336.57819ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:02.505136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:02.168153Z","time spent":"336.889888ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:57:02.661205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.58317ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-30T17:57:02.661303Z","caller":"traceutil/trace.go:171","msg":"trace[379457659] linearizableReadLoop","detail":"{readStateIndex:1277; appliedIndex:1276; }","duration":"125.753329ms","start":"2026-03-30T17:57:02.535533Z","end":"2026-03-30T17:57:02.661286Z","steps":["trace[379457659] 'read index received' (duration: 38.04µs)","trace[379457659] 'applied index is now lower than readState.Index' (duration: 125.713869ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:57:02.664126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.590963ms","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-03-30T17:57:02.66469Z","caller":"traceutil/trace.go:171","msg":"trace[71295426] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1227; }","duration":"129.187615ms","start":"2026-03-30T17:57:02.535485Z","end":"2026-03-30T17:57:02.664673Z","steps":["trace[71295426] 'agreement among raft nodes before linearized reading' (duration: 125.844931ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:02.82358Z","caller":"traceutil/trace.go:171","msg":"trace[1467314928] linearizableReadLoop","detail":"{readStateIndex:1278; appliedIndex:1277; }","duration":"130.141667ms","start":"2026-03-30T17:57:02.693419Z","end":"2026-03-30T17:57:02.823561Z","steps":["trace[1467314928] 'read index received' (duration: 130.005354ms)","trace[1467314928] 'applied index is now lower than readState.Index' (duration: 135.413µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:57:02.823633Z","caller":"traceutil/trace.go:171","msg":"trace[1525180069] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"153.84373ms","start":"2026-03-30T17:57:02.669766Z","end":"2026-03-30T17:57:02.82361Z","steps":["trace[1525180069] 'process raft request' (duration: 153.681856ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:02.823754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.002345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-30T17:57:02.823781Z","caller":"traceutil/trace.go:171","msg":"trace[1935504406] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1228; }","duration":"130.081176ms","start":"2026-03-30T17:57:02.693693Z","end":"2026-03-30T17:57:02.823774Z","steps":["trace[1935504406] 'agreement among raft nodes before linearized reading' (duration: 129.990513ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:02.823783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.365522ms","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-03-30T17:57:02.823805Z","caller":"traceutil/trace.go:171","msg":"trace[1778227215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1228; }","duration":"130.415343ms","start":"2026-03-30T17:57:02.693383Z","end":"2026-03-30T17:57:02.823798Z","steps":["trace[1778227215] 'agreement among raft nodes before linearized reading' (duration: 130.269499ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:02.823871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.073896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-03-30T17:57:02.823875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.052856ms","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-03-30T17:57:02.823922Z","caller":"traceutil/trace.go:171","msg":"trace[1939686977] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1228; }","duration":"130.137947ms","start":"2026-03-30T17:57:02.693773Z","end":"2026-03-30T17:57:02.823911Z","steps":["trace[1939686977] 'agreement among raft nodes before linearized reading' (duration: 129.966044ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:02.823952Z","caller":"traceutil/trace.go:171","msg":"trace[437769969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1228; }","duration":"130.161848ms","start":"2026-03-30T17:57:02.693769Z","end":"2026-03-30T17:57:02.823931Z","steps":["trace[437769969] 'agreement among raft nodes before linearized reading' (duration: 129.934393ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:02.962257Z","caller":"traceutil/trace.go:171","msg":"trace[1363624675] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"135.295331ms","start":"2026-03-30T17:57:02.826942Z","end":"2026-03-30T17:57:02.962237Z","steps":["trace[1363624675] 'process raft request' (duration: 132.459898ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:02.96403Z","caller":"traceutil/trace.go:171","msg":"trace[1521120327] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"134.302979ms","start":"2026-03-30T17:57:02.829703Z","end":"2026-03-30T17:57:02.964006Z","steps":["trace[1521120327] 'process raft request' (duration: 134.237168ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:02.964062Z","caller":"traceutil/trace.go:171","msg":"trace[1240606928] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"134.524304ms","start":"2026-03-30T17:57:02.829509Z","end":"2026-03-30T17:57:02.964034Z","steps":["trace[1240606928] 'process raft request' (duration: 134.268448ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:02.964142Z","caller":"traceutil/trace.go:171","msg":"trace[1166966726] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"133.072012ms","start":"2026-03-30T17:57:02.83102Z","end":"2026-03-30T17:57:02.964092Z","steps":["trace[1166966726] 'process raft request' (duration: 132.954249ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:03.379154Z","caller":"traceutil/trace.go:171","msg":"trace[1601582999] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"120.157667ms","start":"2026-03-30T17:57:03.25897Z","end":"2026-03-30T17:57:03.379128Z","steps":["trace[1601582999] 'process raft request' (duration: 119.982553ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:12.928393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.774961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-30T17:57:12.928478Z","caller":"traceutil/trace.go:171","msg":"trace[1679526705] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1311; }","duration":"196.893024ms","start":"2026-03-30T17:57:12.731568Z","end":"2026-03-30T17:57:12.928461Z","steps":["trace[1679526705] 'count revisions from in-memory index tree' (duration: 196.636518ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:13.510215Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492927053077739,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:57:14.01053Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15961492927053077739,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:57:14.363704Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.274202857s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T17:57:14.364155Z","caller":"traceutil/trace.go:171","msg":"trace[488391934] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"1.43128221s","start":"2026-03-30T17:57:12.932845Z","end":"2026-03-30T17:57:14.364128Z","steps":["trace[488391934] 'process raft request' (duration: 1.431117996s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.364314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:12.932805Z","time spent":"1.431426913s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:57:14.401925Z","caller":"traceutil/trace.go:171","msg":"trace[697591239] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1363; }","duration":"1.39195993s","start":"2026-03-30T17:57:13.009941Z","end":"2026-03-30T17:57:14.401901Z","steps":["trace[697591239] 'read index received' (duration: 1.354123813s)","trace[697591239] 'applied index is now lower than readState.Index' (duration: 37.835197ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:57:14.402101Z","caller":"traceutil/trace.go:171","msg":"trace[750928428] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"692.850956ms","start":"2026-03-30T17:57:13.709238Z","end":"2026-03-30T17:57:14.402089Z","steps":["trace[750928428] 'process raft request' (duration: 692.528709ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.402221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.388248879s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-30T17:57:14.402249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:13.709216Z","time spent":"692.955119ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:57:14.402325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.387954372s","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-03-30T17:57:14.402309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.091754184s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:57:14.402325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342536479s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:57:14.402387Z","caller":"traceutil/trace.go:171","msg":"trace[907982809] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1313; }","duration":"1.091902757s","start":"2026-03-30T17:57:13.310466Z","end":"2026-03-30T17:57:14.402369Z","steps":["trace[907982809] 'agreement among raft nodes before linearized reading' (duration: 1.091735394s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:14.402402Z","caller":"traceutil/trace.go:171","msg":"trace[1637941525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1313; }","duration":"1.342633921s","start":"2026-03-30T17:57:13.059747Z","end":"2026-03-30T17:57:14.402381Z","steps":["trace[1637941525] 'agreement among raft nodes before linearized reading' (duration: 1.342516868s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.402435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:13.310439Z","time spent":"1.09198507s","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-03-30T17:57:14.402262Z","caller":"traceutil/trace.go:171","msg":"trace[1657798706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1313; }","duration":"1.388322461s","start":"2026-03-30T17:57:13.013925Z","end":"2026-03-30T17:57:14.402247Z","steps":["trace[1657798706] 'agreement among raft nodes before linearized reading' (duration: 1.388199398s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.40247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.835202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-03-30T17:57:14.402503Z","caller":"traceutil/trace.go:171","msg":"trace[949222310] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1313; }","duration":"191.922113ms","start":"2026-03-30T17:57:14.210571Z","end":"2026-03-30T17:57:14.402493Z","steps":["trace[949222310] 'agreement among raft nodes before linearized reading' (duration: 191.826431ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.402508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:13.013907Z","time spent":"1.388587196s","remote":"127.0.0.1:60258","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-03-30T17:57:14.402601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392653636s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-03-30T17:57:14.402588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.312805411s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"} {"level":"warn","ts":"2026-03-30T17:57:14.402625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.703679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-03-30T17:57:14.402651Z","caller":"traceutil/trace.go:171","msg":"trace[695544787] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1313; }","duration":"1.392760008s","start":"2026-03-30T17:57:13.009881Z","end":"2026-03-30T17:57:14.402641Z","steps":["trace[695544787] 'agreement among raft nodes before linearized reading' (duration: 1.392575434s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:14.402682Z","caller":"traceutil/trace.go:171","msg":"trace[1188580200] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1313; }","duration":"1.312935854s","start":"2026-03-30T17:57:13.089721Z","end":"2026-03-30T17:57:14.402657Z","steps":["trace[1188580200] 'agreement among raft nodes before linearized reading' (duration: 1.312655398s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.402696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:13.009856Z","time spent":"1.392831039s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-03-30T17:57:14.402701Z","caller":"traceutil/trace.go:171","msg":"trace[1818040741] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1313; }","duration":"339.836442ms","start":"2026-03-30T17:57:14.062848Z","end":"2026-03-30T17:57:14.402685Z","steps":["trace[1818040741] 'agreement among raft nodes before linearized reading' (duration: 339.590407ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.40274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:14.062818Z","time spent":"339.915203ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-03-30T17:57:14.402739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:13.089704Z","time spent":"1.313026286s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":547,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-03-30T17:57:14.40307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.69682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-30T17:57:14.403145Z","caller":"traceutil/trace.go:171","msg":"trace[2139621175] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1313; }","duration":"468.747841ms","start":"2026-03-30T17:57:13.934357Z","end":"2026-03-30T17:57:14.403105Z","steps":["trace[2139621175] 'agreement among raft nodes before linearized reading' (duration: 468.222ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.40319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:13.934298Z","time spent":"468.877535ms","remote":"127.0.0.1:60436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-03-30T17:57:14.403227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:13.059735Z","time spent":"1.343480959s","remote":"127.0.0.1:50238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T17:57:14.402349Z","caller":"traceutil/trace.go:171","msg":"trace[1057111328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1313; }","duration":"1.388016714s","start":"2026-03-30T17:57:13.014326Z","end":"2026-03-30T17:57:14.402343Z","steps":["trace[1057111328] 'agreement among raft nodes before linearized reading' (duration: 1.387953442s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.403445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:13.014285Z","time spent":"1.389149079s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-30T17:57:14.404442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.390397836s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-30T17:57:14.404504Z","caller":"traceutil/trace.go:171","msg":"trace[565741885] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1313; }","duration":"1.390500829s","start":"2026-03-30T17:57:13.013982Z","end":"2026-03-30T17:57:14.404482Z","steps":["trace[565741885] 'agreement among raft nodes before linearized reading' (duration: 1.388380542s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.404551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:57:13.013976Z","time spent":"1.39056644s","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-30T17:57:14.58724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.66506ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:57:14.587389Z","caller":"traceutil/trace.go:171","msg":"trace[552922565] linearizableReadLoop","detail":"{readStateIndex:1366; appliedIndex:1365; }","duration":"179.017417ms","start":"2026-03-30T17:57:14.408354Z","end":"2026-03-30T17:57:14.587372Z","steps":["trace[552922565] 'read index received' (duration: 177.738048ms)","trace[552922565] 'applied index is now lower than readState.Index' (duration: 1.278449ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:57:14.587427Z","caller":"traceutil/trace.go:171","msg":"trace[1387807153] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1313; }","duration":"121.889455ms","start":"2026-03-30T17:57:14.46551Z","end":"2026-03-30T17:57:14.5874Z","steps":["trace[1387807153] 'range keys from in-memory index tree' (duration: 121.639619ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:14.587617Z","caller":"traceutil/trace.go:171","msg":"trace[360389034] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"179.913787ms","start":"2026-03-30T17:57:14.40769Z","end":"2026-03-30T17:57:14.587604Z","steps":["trace[360389034] 'process raft request' (duration: 178.24021ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.587807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.434617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-30T17:57:14.587837Z","caller":"traceutil/trace.go:171","msg":"trace[242645865] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1314; }","duration":"179.502118ms","start":"2026-03-30T17:57:14.408329Z","end":"2026-03-30T17:57:14.587831Z","steps":["trace[242645865] 'agreement among raft nodes before linearized reading' (duration: 179.424746ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:14.596521Z","caller":"traceutil/trace.go:171","msg":"trace[567349655] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"188.139629ms","start":"2026-03-30T17:57:14.408362Z","end":"2026-03-30T17:57:14.596502Z","steps":["trace[567349655] 'process raft request' (duration: 187.854122ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:14.596657Z","caller":"traceutil/trace.go:171","msg":"trace[104414859] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"188.2326ms","start":"2026-03-30T17:57:14.408402Z","end":"2026-03-30T17:57:14.596635Z","steps":["trace[104414859] 'process raft request' (duration: 187.948984ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:14.596764Z","caller":"traceutil/trace.go:171","msg":"trace[328190305] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"188.270542ms","start":"2026-03-30T17:57:14.408477Z","end":"2026-03-30T17:57:14.596748Z","steps":["trace[328190305] 'process raft request' (duration: 188.089188ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:14.596979Z","caller":"traceutil/trace.go:171","msg":"trace[2035704485] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"188.440666ms","start":"2026-03-30T17:57:14.40852Z","end":"2026-03-30T17:57:14.596961Z","steps":["trace[2035704485] 'process raft request' (duration: 188.318493ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:14.597092Z","caller":"traceutil/trace.go:171","msg":"trace[832144053] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"188.521397ms","start":"2026-03-30T17:57:14.408561Z","end":"2026-03-30T17:57:14.597082Z","steps":["trace[832144053] 'process raft request' (duration: 188.366234ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:57:14.597534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.344269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:57:14.59762Z","caller":"traceutil/trace.go:171","msg":"trace[241356694] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1321; }","duration":"186.450211ms","start":"2026-03-30T17:57:14.411154Z","end":"2026-03-30T17:57:14.597605Z","steps":["trace[241356694] 'agreement among raft nodes before linearized reading' (duration: 186.316418ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:57:14.597561Z","caller":"traceutil/trace.go:171","msg":"trace[192073979] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"188.828143ms","start":"2026-03-30T17:57:14.408719Z","end":"2026-03-30T17:57:14.597547Z","steps":["trace[192073979] 'process raft request' (duration: 188.315882ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:27.873335Z","caller":"traceutil/trace.go:171","msg":"trace[794010892] linearizableReadLoop","detail":"{readStateIndex:2324; appliedIndex:2323; }","duration":"176.869603ms","start":"2026-03-30T18:00:27.696437Z","end":"2026-03-30T18:00:27.873307Z","steps":["trace[794010892] 'read index received' (duration: 176.657568ms)","trace[794010892] 'applied index is now lower than readState.Index' (duration: 211.155µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T18:00:27.873803Z","caller":"traceutil/trace.go:171","msg":"trace[1177596080] transaction","detail":"{read_only:false; response_revision:2232; number_of_response:1; }","duration":"203.375088ms","start":"2026-03-30T18:00:27.670414Z","end":"2026-03-30T18:00:27.873789Z","steps":["trace[1177596080] 'process raft request' (duration: 202.751485ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:27.874092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.638119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-03-30T18:00:27.874124Z","caller":"traceutil/trace.go:171","msg":"trace[832169724] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2232; }","duration":"177.730431ms","start":"2026-03-30T18:00:27.696384Z","end":"2026-03-30T18:00:27.874114Z","steps":["trace[832169724] 'agreement among raft nodes before linearized reading' (duration: 177.594998ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:27.874328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.890681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-03-30T18:00:27.874355Z","caller":"traceutil/trace.go:171","msg":"trace[653849234] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2232; }","duration":"175.949753ms","start":"2026-03-30T18:00:27.698397Z","end":"2026-03-30T18:00:27.874347Z","steps":["trace[653849234] 'agreement among raft nodes before linearized reading' (duration: 175.847791ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:27.874715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.143461ms","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-03-30T18:00:27.874752Z","caller":"traceutil/trace.go:171","msg":"trace[1284664349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2232; }","duration":"173.206542ms","start":"2026-03-30T18:00:27.701537Z","end":"2026-03-30T18:00:27.874743Z","steps":["trace[1284664349] 'agreement among raft nodes before linearized reading' (duration: 173.095259ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:27.874933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.476238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-03-30T18:00:27.874965Z","caller":"traceutil/trace.go:171","msg":"trace[465414039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2232; }","duration":"173.536039ms","start":"2026-03-30T18:00:27.701421Z","end":"2026-03-30T18:00:27.874957Z","steps":["trace[465414039] 'agreement among raft nodes before linearized reading' (duration: 173.461068ms)"],"step_count":1}