{"level":"warn","ts":"2026-05-07T00:48:31.435434Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T00:48:31.43556Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238: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-05-07T00:48:31.435663Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T00:48:31.435683Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-05-07T00:48:31.435719Z","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-05-07T00:48:31.436573Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]} {"level":"info","ts":"2026-05-07T00:48:31.436677Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238: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-05-07T00:48:31.440785Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.824193ms"} {"level":"info","ts":"2026-05-07T00:48:31.456439Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-05-07T00:48:31.456567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-07T00:48:31.456593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-05-07T00:48:31.456604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-07T00:48:31.456645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-05-07T00:48:31.456682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-05-07T00:48:31.465148Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-07T00:48:31.46632Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-07T00:48:31.467336Z","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-05-07T00:48:31.469356Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-07T00:48:31.47006Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-07T00:48:31.470085Z","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-05-07T00:48:31.471651Z","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-05-07T00:48:31.471678Z","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-05-07T00:48:31.472431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-05-07T00:48:31.472594Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-05-07T00:48:31.480363Z","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-05-07T00:48:31.480782Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-07T00:48:31.480845Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-07T00:48:31.481061Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-05-07T00:48:31.481138Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-05-07T00:48:31.657018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-07T00:48:31.657073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-07T00:48:31.657099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-05-07T00:48:31.657114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-05-07T00:48:31.657126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-05-07T00:48:31.657138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-05-07T00:48:31.657148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-05-07T00:48:31.6578Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"} {"level":"info","ts":"2026-05-07T00:48:31.657937Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T00:48:31.658175Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T00:48:31.658356Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-07T00:48:31.658373Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-07T00:48:31.660096Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:48:31.661514Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:48:31.661614Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:48:31.661761Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T00:48:31.663081Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-07T00:48:31.665272Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-05-07T00:48:49.756147Z","caller":"traceutil/trace.go:171","msg":"trace[1357935421] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"182.391829ms","start":"2026-05-07T00:48:49.57373Z","end":"2026-05-07T00:48:49.756122Z","steps":["trace[1357935421] 'process raft request' (duration: 182.241966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:48:50.244517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.713094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-07T00:48:50.244629Z","caller":"traceutil/trace.go:171","msg":"trace[1867689733] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:446; }","duration":"170.878788ms","start":"2026-05-07T00:48:50.073728Z","end":"2026-05-07T00:48:50.244607Z","steps":["trace[1867689733] 'range keys from in-memory index tree' (duration: 170.55711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:48:50.244632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.953234ms","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-05-07T00:48:50.244677Z","caller":"traceutil/trace.go:171","msg":"trace[867460401] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:446; }","duration":"225.996145ms","start":"2026-05-07T00:48:50.018668Z","end":"2026-05-07T00:48:50.244664Z","steps":["trace[867460401] 'range keys from in-memory index tree' (duration: 225.79555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:48:50.244517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.581525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-05-07T00:48:50.244799Z","caller":"traceutil/trace.go:171","msg":"trace[1516295441] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:446; }","duration":"407.914893ms","start":"2026-05-07T00:48:49.836872Z","end":"2026-05-07T00:48:50.244787Z","steps":["trace[1516295441] 'range keys from in-memory index tree' (duration: 407.469492ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:48:50.244852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:48:49.836842Z","time spent":"407.997124ms","remote":"127.0.0.1:55526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4350,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-05-07T00:48:50.830147Z","caller":"traceutil/trace.go:171","msg":"trace[1327831683] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"580.251635ms","start":"2026-05-07T00:48:50.249864Z","end":"2026-05-07T00:48:50.830116Z","steps":["trace[1327831683] 'process raft request' (duration: 580.169853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:48:50.830472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:48:50.249843Z","time spent":"580.356008ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:48:51.460057Z","caller":"traceutil/trace.go:171","msg":"trace[1338002761] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"1.208593646s","start":"2026-05-07T00:48:50.251403Z","end":"2026-05-07T00:48:51.459997Z","steps":["trace[1338002761] 'process raft request' (duration: 1.208415912s)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:48:51.460275Z","caller":"traceutil/trace.go:171","msg":"trace[314634461] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"1.207736585s","start":"2026-05-07T00:48:50.2525Z","end":"2026-05-07T00:48:51.460236Z","steps":["trace[314634461] 'process raft request' (duration: 1.207433388s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:48:51.460423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:48:50.251379Z","time spent":"1.208956275s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:48:51.460433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:48:50.252489Z","time spent":"1.207857688s","remote":"127.0.0.1:55526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:48:51.569491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.21272ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-07T00:48:51.569613Z","caller":"traceutil/trace.go:171","msg":"trace[1192049647] linearizableReadLoop","detail":"{readStateIndex:465; appliedIndex:462; }","duration":"1.022868766s","start":"2026-05-07T00:48:50.546697Z","end":"2026-05-07T00:48:51.569566Z","steps":["trace[1192049647] 'read index received' (duration: 283.45668ms)","trace[1192049647] 'applied index is now lower than readState.Index' (duration: 739.410306ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:48:51.569745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.02304612s","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-05-07T00:48:51.569781Z","caller":"traceutil/trace.go:171","msg":"trace[1910795710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:449; }","duration":"1.023119602s","start":"2026-05-07T00:48:50.546653Z","end":"2026-05-07T00:48:51.569772Z","steps":["trace[1910795710] 'agreement among raft nodes before linearized reading' (duration: 1.0230357s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:48:51.569817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:48:50.546635Z","time spent":"1.023174414s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T00:48:51.569875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.888259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-05-07T00:48:51.569965Z","caller":"traceutil/trace.go:171","msg":"trace[40073691] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:449; }","duration":"106.021382ms","start":"2026-05-07T00:48:51.463921Z","end":"2026-05-07T00:48:51.569942Z","steps":["trace[40073691] 'agreement among raft nodes before linearized reading' (duration: 105.851477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:48:51.57016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.182038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:48:51.570766Z","caller":"traceutil/trace.go:171","msg":"trace[1284491927] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:449; }","duration":"482.975707ms","start":"2026-05-07T00:48:51.08776Z","end":"2026-05-07T00:48:51.570735Z","steps":["trace[1284491927] 'agreement among raft nodes before linearized reading' (duration: 482.063265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:48:51.570912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:48:51.08774Z","time spent":"483.154672ms","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T00:49:02.598827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.862062ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T00:49:02.59896Z","caller":"traceutil/trace.go:171","msg":"trace[1984183423] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"331.162976ms","start":"2026-05-07T00:49:02.267773Z","end":"2026-05-07T00:49:02.598936Z","steps":["trace[1984183423] 'process raft request' (duration: 134.101449ms)","trace[1984183423] 'compare' (duration: 195.721405ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:49:02.599031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:02.267753Z","time spent":"331.249588ms","remote":"127.0.0.1:55390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T00:49:02.602442Z","caller":"traceutil/trace.go:171","msg":"trace[784655017] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"255.28315ms","start":"2026-05-07T00:49:02.347137Z","end":"2026-05-07T00:49:02.60242Z","steps":["trace[784655017] 'process raft request' (duration: 254.876281ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:02.61891Z","caller":"traceutil/trace.go:171","msg":"trace[1037658071] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:615; }","duration":"146.701877ms","start":"2026-05-07T00:49:02.472186Z","end":"2026-05-07T00:49:02.618888Z","steps":["trace[1037658071] 'read index received' (duration: 129.804834ms)","trace[1037658071] 'applied index is now lower than readState.Index' (duration: 16.896373ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:49:02.618931Z","caller":"traceutil/trace.go:171","msg":"trace[102625668] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"188.861897ms","start":"2026-05-07T00:49:02.430047Z","end":"2026-05-07T00:49:02.618909Z","steps":["trace[102625668] 'process raft request' (duration: 187.929414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:02.619078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.873882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-nglfk\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-05-07T00:49:02.619116Z","caller":"traceutil/trace.go:171","msg":"trace[1395605876] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-nglfk; range_end:; response_count:1; response_revision:596; }","duration":"146.945733ms","start":"2026-05-07T00:49:02.472161Z","end":"2026-05-07T00:49:02.619106Z","steps":["trace[1395605876] 'agreement among raft nodes before linearized reading' (duration: 146.806549ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:02.61917Z","caller":"traceutil/trace.go:171","msg":"trace[82497840] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"151.856113ms","start":"2026-05-07T00:49:02.467305Z","end":"2026-05-07T00:49:02.619161Z","steps":["trace[82497840] 'process raft request' (duration: 151.552036ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:08.894963Z","caller":"traceutil/trace.go:171","msg":"trace[1370384125] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"387.489343ms","start":"2026-05-07T00:49:08.507437Z","end":"2026-05-07T00:49:08.894927Z","steps":["trace[1370384125] 'process raft request' (duration: 387.278368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:08.895173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:08.507412Z","time spent":"387.662888ms","remote":"127.0.0.1:55526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:49:09.08877Z","caller":"traceutil/trace.go:171","msg":"trace[1370679086] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"117.01467ms","start":"2026-05-07T00:49:08.971722Z","end":"2026-05-07T00:49:09.088736Z","steps":["trace[1370679086] 'process raft request' (duration: 61.263566ms)","trace[1370679086] 'compare' (duration: 55.61491ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:49:10.176603Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532216031536513,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T00:49:10.682513Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532216031536513,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T00:49:11.001693Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.439337709s","expected-duration":"1s"} {"level":"info","ts":"2026-05-07T00:49:11.00217Z","caller":"traceutil/trace.go:171","msg":"trace[11134853] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"1.439908113s","start":"2026-05-07T00:49:09.562232Z","end":"2026-05-07T00:49:11.00214Z","steps":["trace[11134853] 'process raft request' (duration: 1.439723338s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.002375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:09.562206Z","time spent":"1.440084768s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:49:11.007549Z","caller":"traceutil/trace.go:171","msg":"trace[1847818925] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:699; }","duration":"1.331956883s","start":"2026-05-07T00:49:09.675558Z","end":"2026-05-07T00:49:11.007515Z","steps":["trace[1847818925] 'read index received' (duration: 1.326433378s)","trace[1847818925] 'applied index is now lower than readState.Index' (duration: 5.521695ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:49:11.007957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.339909ms","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":"warn","ts":"2026-05-07T00:49:11.00798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.707665ms","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-05-07T00:49:11.00803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.041259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.008095Z","caller":"traceutil/trace.go:171","msg":"trace[1377206602] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:677; }","duration":"240.883799ms","start":"2026-05-07T00:49:10.767187Z","end":"2026-05-07T00:49:11.008071Z","steps":["trace[1377206602] 'agreement among raft nodes before linearized reading' (duration: 240.631853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.008147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.315752ms","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-05-07T00:49:11.008201Z","caller":"traceutil/trace.go:171","msg":"trace[776488252] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:677; }","duration":"255.408984ms","start":"2026-05-07T00:49:10.752785Z","end":"2026-05-07T00:49:11.008194Z","steps":["trace[776488252] 'agreement among raft nodes before linearized reading' (duration: 255.321852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.008249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.378479ms","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-05-07T00:49:11.008315Z","caller":"traceutil/trace.go:171","msg":"trace[725039339] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:677; }","duration":"472.528382ms","start":"2026-05-07T00:49:10.53577Z","end":"2026-05-07T00:49:11.008298Z","steps":["trace[725039339] 'agreement among raft nodes before linearized reading' (duration: 472.41826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.008358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.535729Z","time spent":"472.618405ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-07T00:49:11.008429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.020608ms","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":"warn","ts":"2026-05-07T00:49:11.008341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.288952982s","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-05-07T00:49:11.008593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.30171ms","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-05-07T00:49:11.008622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.862847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.008642Z","caller":"traceutil/trace.go:171","msg":"trace[1033925547] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:677; }","duration":"286.398282ms","start":"2026-05-07T00:49:10.722236Z","end":"2026-05-07T00:49:11.008634Z","steps":["trace[1033925547] 'agreement among raft nodes before linearized reading' (duration: 286.3357ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.008088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.885549ms","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":"info","ts":"2026-05-07T00:49:11.008705Z","caller":"traceutil/trace.go:171","msg":"trace[1895592286] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:677; }","duration":"241.542295ms","start":"2026-05-07T00:49:10.767156Z","end":"2026-05-07T00:49:11.008698Z","steps":["trace[1895592286] 'agreement among raft nodes before linearized reading' (duration: 240.883919ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.008727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.389724ms","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":"warn","ts":"2026-05-07T00:49:11.008589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.259129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.008832Z","caller":"traceutil/trace.go:171","msg":"trace[2024308632] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:677; }","duration":"473.511096ms","start":"2026-05-07T00:49:10.53531Z","end":"2026-05-07T00:49:11.008821Z","steps":["trace[2024308632] 'agreement among raft nodes before linearized reading' (duration: 473.340802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.009036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.72542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T00:49:11.009086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.005933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.009168Z","caller":"traceutil/trace.go:171","msg":"trace[1399500483] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:677; }","duration":"448.093474ms","start":"2026-05-07T00:49:10.561056Z","end":"2026-05-07T00:49:11.00915Z","steps":["trace[1399500483] 'agreement among raft nodes before linearized reading' (duration: 447.9281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.009183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.535306Z","time spent":"473.739232ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T00:49:11.009201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.153686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.009259Z","caller":"traceutil/trace.go:171","msg":"trace[585124222] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:677; }","duration":"448.240769ms","start":"2026-05-07T00:49:10.561005Z","end":"2026-05-07T00:49:11.009246Z","steps":["trace[585124222] 'agreement among raft nodes before linearized reading' (duration: 448.158797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.009022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.349384ms","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":"info","ts":"2026-05-07T00:49:11.009387Z","caller":"traceutil/trace.go:171","msg":"trace[1992522964] 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:677; }","duration":"343.731963ms","start":"2026-05-07T00:49:10.665646Z","end":"2026-05-07T00:49:11.009378Z","steps":["trace[1992522964] 'agreement among raft nodes before linearized reading' (duration: 343.360954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.009463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.156802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T00:49:11.009493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.901092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.009543Z","caller":"traceutil/trace.go:171","msg":"trace[1957172279] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:677; }","duration":"362.989455ms","start":"2026-05-07T00:49:10.646542Z","end":"2026-05-07T00:49:11.009532Z","steps":["trace[1957172279] 'agreement among raft nodes before linearized reading' (duration: 362.915973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.009559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.101066ms","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-05-07T00:49:11.009563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.390252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.010794Z","caller":"traceutil/trace.go:171","msg":"trace[1130655660] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:677; }","duration":"242.811036ms","start":"2026-05-07T00:49:10.767965Z","end":"2026-05-07T00:49:11.010776Z","steps":["trace[1130655660] 'agreement among raft nodes before linearized reading' (duration: 241.374381ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:11.008669Z","caller":"traceutil/trace.go:171","msg":"trace[1772771121] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:677; }","duration":"388.962019ms","start":"2026-05-07T00:49:10.619695Z","end":"2026-05-07T00:49:11.008657Z","steps":["trace[1772771121] 'agreement among raft nodes before linearized reading' (duration: 388.892538ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.010929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.619664Z","time spent":"391.240605ms","remote":"127.0.0.1:34606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:49:11.008566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.340614ms","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-05-07T00:49:11.011024Z","caller":"traceutil/trace.go:171","msg":"trace[1527572645] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:677; }","duration":"391.068811ms","start":"2026-05-07T00:49:10.619941Z","end":"2026-05-07T00:49:11.01101Z","steps":["trace[1527572645] 'agreement among raft nodes before linearized reading' (duration: 388.309773ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.011113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.619935Z","time spent":"391.140442ms","remote":"127.0.0.1:34606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-05-07T00:49:11.009508Z","caller":"traceutil/trace.go:171","msg":"trace[731749822] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:677; }","duration":"474.228944ms","start":"2026-05-07T00:49:10.535267Z","end":"2026-05-07T00:49:11.009496Z","steps":["trace[731749822] 'agreement among raft nodes before linearized reading' (duration: 474.138782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.011207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.535246Z","time spent":"475.942385ms","remote":"127.0.0.1:34584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:49:11.009586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.646527Z","time spent":"363.045126ms","remote":"127.0.0.1:34608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:49:11.008836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.01635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.011453Z","caller":"traceutil/trace.go:171","msg":"trace[1032601903] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:677; }","duration":"364.711217ms","start":"2026-05-07T00:49:10.646733Z","end":"2026-05-07T00:49:11.011445Z","steps":["trace[1032601903] 'agreement among raft nodes before linearized reading' (duration: 361.853747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.011495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.646711Z","time spent":"364.774869ms","remote":"127.0.0.1:34608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"info","ts":"2026-05-07T00:49:11.008618Z","caller":"traceutil/trace.go:171","msg":"trace[303537535] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:677; }","duration":"1.289327731s","start":"2026-05-07T00:49:09.71927Z","end":"2026-05-07T00:49:11.008598Z","steps":["trace[303537535] 'agreement among raft nodes before linearized reading' (duration: 1.288632654s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.011606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:09.719224Z","time spent":"1.292359865s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-07T00:49:11.009303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.560939Z","time spent":"448.352711ms","remote":"127.0.0.1:34592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-05-07T00:49:11.009092Z","caller":"traceutil/trace.go:171","msg":"trace[544296182] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:677; }","duration":"158.786512ms","start":"2026-05-07T00:49:10.850275Z","end":"2026-05-07T00:49:11.009062Z","steps":["trace[544296182] 'agreement among raft nodes before linearized reading' (duration: 158.724301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.009211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.561051Z","time spent":"448.148396ms","remote":"127.0.0.1:34592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-05-07T00:49:11.008492Z","caller":"traceutil/trace.go:171","msg":"trace[518542317] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:677; }","duration":"256.077901ms","start":"2026-05-07T00:49:10.752386Z","end":"2026-05-07T00:49:11.008464Z","steps":["trace[518542317] 'agreement among raft nodes before linearized reading' (duration: 256.018459ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:11.008154Z","caller":"traceutil/trace.go:171","msg":"trace[1126718383] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:677; }","duration":"157.213063ms","start":"2026-05-07T00:49:10.850914Z","end":"2026-05-07T00:49:11.008128Z","steps":["trace[1126718383] 'agreement among raft nodes before linearized reading' (duration: 156.960927ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.008554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.187902ms","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":"info","ts":"2026-05-07T00:49:11.012217Z","caller":"traceutil/trace.go:171","msg":"trace[1762722355] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:677; }","duration":"259.950245ms","start":"2026-05-07T00:49:10.75226Z","end":"2026-05-07T00:49:11.01221Z","steps":["trace[1762722355] 'agreement among raft nodes before linearized reading' (duration: 256.246435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.008906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.819322ms","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-05-07T00:49:11.012684Z","caller":"traceutil/trace.go:171","msg":"trace[773847448] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:677; }","duration":"290.594545ms","start":"2026-05-07T00:49:10.722078Z","end":"2026-05-07T00:49:11.012672Z","steps":["trace[773847448] 'agreement among raft nodes before linearized reading' (duration: 286.806242ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.008895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.346479ms","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-05-07T00:49:11.012905Z","caller":"traceutil/trace.go:171","msg":"trace[29114897] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:677; }","duration":"393.378287ms","start":"2026-05-07T00:49:10.619508Z","end":"2026-05-07T00:49:11.012886Z","steps":["trace[29114897] 'agreement among raft nodes before linearized reading' (duration: 389.326968ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.012956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.619492Z","time spent":"393.447449ms","remote":"127.0.0.1:34606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T00:49:11.008939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.297757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.01306Z","caller":"traceutil/trace.go:171","msg":"trace[712472126] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:677; }","duration":"321.409788ms","start":"2026-05-07T00:49:10.691636Z","end":"2026-05-07T00:49:11.013045Z","steps":["trace[712472126] 'agreement among raft nodes before linearized reading' (duration: 317.286617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.013122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.691603Z","time spent":"321.50671ms","remote":"127.0.0.1:34630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:49:11.008929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.604571ms","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-05-07T00:49:11.008964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.422801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.013387Z","caller":"traceutil/trace.go:171","msg":"trace[1459526565] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:677; }","duration":"321.869199ms","start":"2026-05-07T00:49:10.691507Z","end":"2026-05-07T00:49:11.013376Z","steps":["trace[1459526565] 'agreement among raft nodes before linearized reading' (duration: 317.44377ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:11.013257Z","caller":"traceutil/trace.go:171","msg":"trace[1437694636] 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:677; }","duration":"347.924776ms","start":"2026-05-07T00:49:10.665309Z","end":"2026-05-07T00:49:11.013234Z","steps":["trace[1437694636] 'agreement among raft nodes before linearized reading' (duration: 343.58727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.013422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.691488Z","time spent":"321.923331ms","remote":"127.0.0.1:34630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T00:49:11.008962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.488679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.013484Z","caller":"traceutil/trace.go:171","msg":"trace[665017818] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:677; }","duration":"452.024661ms","start":"2026-05-07T00:49:10.561447Z","end":"2026-05-07T00:49:11.013472Z","steps":["trace[665017818] 'agreement among raft nodes before linearized reading' (duration: 447.47975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.013527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.56144Z","time spent":"452.071082ms","remote":"127.0.0.1:34592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-07T00:49:11.008982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.717639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.013687Z","caller":"traceutil/trace.go:171","msg":"trace[236285842] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:677; }","duration":"201.458295ms","start":"2026-05-07T00:49:10.812217Z","end":"2026-05-07T00:49:11.013675Z","steps":["trace[236285842] 'agreement among raft nodes before linearized reading' (duration: 196.7417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.008995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.474951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.013832Z","caller":"traceutil/trace.go:171","msg":"trace[1500492836] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:677; }","duration":"322.321181ms","start":"2026-05-07T00:49:10.691502Z","end":"2026-05-07T00:49:11.013823Z","steps":["trace[1500492836] 'agreement among raft nodes before linearized reading' (duration: 317.478112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.013867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.691491Z","time spent":"322.364182ms","remote":"127.0.0.1:34630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"info","ts":"2026-05-07T00:49:11.00904Z","caller":"traceutil/trace.go:171","msg":"trace[1091006942] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:677; }","duration":"158.70782ms","start":"2026-05-07T00:49:10.850311Z","end":"2026-05-07T00:49:11.009019Z","steps":["trace[1091006942] 'agreement among raft nodes before linearized reading' (duration: 158.225478ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:11.009593Z","caller":"traceutil/trace.go:171","msg":"trace[2138223311] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:677; }","duration":"608.152028ms","start":"2026-05-07T00:49:10.401429Z","end":"2026-05-07T00:49:11.009581Z","steps":["trace[2138223311] 'agreement among raft nodes before linearized reading' (duration: 608.099897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.014067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.401376Z","time spent":"612.678369ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-07T00:49:11.009634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.665633Z","time spent":"343.851866ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"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-05-07T00:49:11.009639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.737332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.014436Z","caller":"traceutil/trace.go:171","msg":"trace[900888688] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:677; }","duration":"613.593262ms","start":"2026-05-07T00:49:10.40083Z","end":"2026-05-07T00:49:11.014423Z","steps":["trace[900888688] 'agreement among raft nodes before linearized reading' (duration: 608.785824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.014483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.40079Z","time spent":"613.679214ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:49:11.009674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.106451ms","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":"info","ts":"2026-05-07T00:49:11.01467Z","caller":"traceutil/trace.go:171","msg":"trace[372408452] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:677; }","duration":"614.137654ms","start":"2026-05-07T00:49:10.400522Z","end":"2026-05-07T00:49:11.01466Z","steps":["trace[372408452] 'agreement among raft nodes before linearized reading' (duration: 609.134352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.014727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.400501Z","time spent":"614.210277ms","remote":"127.0.0.1:34582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T00:49:11.009707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.563977ms","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-05-07T00:49:11.014948Z","caller":"traceutil/trace.go:171","msg":"trace[1841609575] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:677; }","duration":"669.821276ms","start":"2026-05-07T00:49:10.345114Z","end":"2026-05-07T00:49:11.014935Z","steps":["trace[1841609575] 'agreement among raft nodes before linearized reading' (duration: 664.574817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.014993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.345103Z","time spent":"669.876757ms","remote":"127.0.0.1:34574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-07T00:49:11.009726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.291585ms","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-05-07T00:49:11.015141Z","caller":"traceutil/trace.go:171","msg":"trace[1527434752] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:677; }","duration":"670.747208ms","start":"2026-05-07T00:49:10.344383Z","end":"2026-05-07T00:49:11.01513Z","steps":["trace[1527434752] 'agreement among raft nodes before linearized reading' (duration: 665.311715ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.015182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.344349Z","time spent":"670.82144ms","remote":"127.0.0.1:34574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:49:11.00974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.673892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.015259Z","caller":"traceutil/trace.go:171","msg":"trace[1884806616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"929.233108ms","start":"2026-05-07T00:49:10.086017Z","end":"2026-05-07T00:49:11.01525Z","steps":["trace[1884806616] 'agreement among raft nodes before linearized reading' (duration: 923.705232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.015292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.085991Z","time spent":"929.29302ms","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-07T00:49:11.008019Z","caller":"traceutil/trace.go:171","msg":"trace[1842074289] 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:677; }","duration":"342.429071ms","start":"2026-05-07T00:49:10.665578Z","end":"2026-05-07T00:49:11.008007Z","steps":["trace[1842074289] 'agreement among raft nodes before linearized reading' (duration: 342.335809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.015406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.66557Z","time spent":"349.821942ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"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-05-07T00:49:11.009773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.319395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.01552Z","caller":"traceutil/trace.go:171","msg":"trace[2052565262] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:677; }","duration":"671.071886ms","start":"2026-05-07T00:49:10.344431Z","end":"2026-05-07T00:49:11.015503Z","steps":["trace[2052565262] 'agreement among raft nodes before linearized reading' (duration: 665.319445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.015577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.344349Z","time spent":"671.205959ms","remote":"127.0.0.1:34574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T00:49:11.00982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.139318084s","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-05-07T00:49:11.015676Z","caller":"traceutil/trace.go:171","msg":"trace[101035128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:677; }","duration":"1.145232619s","start":"2026-05-07T00:49:09.870433Z","end":"2026-05-07T00:49:11.015666Z","steps":["trace[101035128] 'agreement among raft nodes before linearized reading' (duration: 1.139321934s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.015707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:09.870415Z","time spent":"1.14528398s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-07T00:49:11.01017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.334618838s","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-05-07T00:49:11.01581Z","caller":"traceutil/trace.go:171","msg":"trace[2069051761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:677; }","duration":"1.340295377s","start":"2026-05-07T00:49:09.675499Z","end":"2026-05-07T00:49:11.015794Z","steps":["trace[2069051761] 'agreement among raft nodes before linearized reading' (duration: 1.332271631s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.015855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:09.675474Z","time spent":"1.340370289s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T00:49:11.008902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.280287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.015937Z","caller":"traceutil/trace.go:171","msg":"trace[1792556623] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:677; }","duration":"369.335659ms","start":"2026-05-07T00:49:10.646591Z","end":"2026-05-07T00:49:11.015926Z","steps":["trace[1792556623] 'agreement among raft nodes before linearized reading' (duration: 362.02468ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.01597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.646583Z","time spent":"369.377211ms","remote":"127.0.0.1:34608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-05-07T00:49:11.009398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.036927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:11.016099Z","caller":"traceutil/trace.go:171","msg":"trace[1367189443] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:677; }","duration":"203.764922ms","start":"2026-05-07T00:49:10.812321Z","end":"2026-05-07T00:49:11.016086Z","steps":["trace[1367189443] 'agreement among raft nodes before linearized reading' (duration: 196.795301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:11.016233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:10.665277Z","time spent":"348.158511ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-07T00:49:28.300386Z","caller":"traceutil/trace.go:171","msg":"trace[971026524] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"677.397608ms","start":"2026-05-07T00:49:27.622966Z","end":"2026-05-07T00:49:28.300364Z","steps":["trace[971026524] 'process raft request' (duration: 677.272855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:28.300549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:27.622943Z","time spent":"677.518111ms","remote":"127.0.0.1:55570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:49:36.845339Z","caller":"traceutil/trace.go:171","msg":"trace[1669556551] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"138.21231ms","start":"2026-05-07T00:49:36.70711Z","end":"2026-05-07T00:49:36.845322Z","steps":["trace[1669556551] 'process raft request' (duration: 138.111077ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:42.285492Z","caller":"traceutil/trace.go:171","msg":"trace[170048557] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"130.37747ms","start":"2026-05-07T00:49:42.155084Z","end":"2026-05-07T00:49:42.285461Z","steps":["trace[170048557] 'process raft request' (duration: 130.091743ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:42.41488Z","caller":"traceutil/trace.go:171","msg":"trace[1877027088] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"120.837849ms","start":"2026-05-07T00:49:42.294017Z","end":"2026-05-07T00:49:42.414855Z","steps":["trace[1877027088] 'process raft request' (duration: 120.785707ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:42.415136Z","caller":"traceutil/trace.go:171","msg":"trace[1249467691] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"123.583355ms","start":"2026-05-07T00:49:42.291542Z","end":"2026-05-07T00:49:42.415125Z","steps":["trace[1249467691] 'process raft request' (duration: 123.216526ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:42.415104Z","caller":"traceutil/trace.go:171","msg":"trace[1491447835] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"124.092678ms","start":"2026-05-07T00:49:42.290988Z","end":"2026-05-07T00:49:42.415081Z","steps":["trace[1491447835] 'process raft request' (duration: 123.648757ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:45.524314Z","caller":"traceutil/trace.go:171","msg":"trace[571844945] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"129.829396ms","start":"2026-05-07T00:49:45.394463Z","end":"2026-05-07T00:49:45.524293Z","steps":["trace[571844945] 'process raft request' (duration: 129.773775ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:45.524745Z","caller":"traceutil/trace.go:171","msg":"trace[1712119291] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"130.493393ms","start":"2026-05-07T00:49:45.39422Z","end":"2026-05-07T00:49:45.524714Z","steps":["trace[1712119291] 'process raft request' (duration: 129.191161ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:45.52513Z","caller":"traceutil/trace.go:171","msg":"trace[1755659609] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"100.756642ms","start":"2026-05-07T00:49:45.424325Z","end":"2026-05-07T00:49:45.525082Z","steps":["trace[1755659609] 'process raft request' (duration: 100.493755ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:57.687545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.637891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:49:57.687632Z","caller":"traceutil/trace.go:171","msg":"trace[1436344138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:985; }","duration":"601.775105ms","start":"2026-05-07T00:49:57.085839Z","end":"2026-05-07T00:49:57.687615Z","steps":["trace[1436344138] 'range keys from in-memory index tree' (duration: 601.57568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:57.687666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:57.085822Z","time spent":"601.837586ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T00:49:57.687702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.116241ms","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-05-07T00:49:57.687778Z","caller":"traceutil/trace.go:171","msg":"trace[1540534487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:985; }","duration":"212.241884ms","start":"2026-05-07T00:49:57.475518Z","end":"2026-05-07T00:49:57.68776Z","steps":["trace[1540534487] 'range keys from in-memory index tree' (duration: 211.952577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:57.687824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.062303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-07T00:49:57.687825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.305581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-07T00:49:57.687898Z","caller":"traceutil/trace.go:171","msg":"trace[523543098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:985; }","duration":"272.173746ms","start":"2026-05-07T00:49:57.415704Z","end":"2026-05-07T00:49:57.687877Z","steps":["trace[523543098] 'range keys from in-memory index tree' (duration: 271.941981ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:49:57.68793Z","caller":"traceutil/trace.go:171","msg":"trace[1611382063] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:985; }","duration":"355.458885ms","start":"2026-05-07T00:49:57.332447Z","end":"2026-05-07T00:49:57.687906Z","steps":["trace[1611382063] 'count revisions from in-memory index tree' (duration: 355.182398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:57.687984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:57.33243Z","time spent":"355.539177ms","remote":"127.0.0.1:55840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:49:57.688153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.607515ms","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-05-07T00:49:57.688206Z","caller":"traceutil/trace.go:171","msg":"trace[1119547252] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:985; }","duration":"321.696097ms","start":"2026-05-07T00:49:57.366496Z","end":"2026-05-07T00:49:57.688192Z","steps":["trace[1119547252] 'range keys from in-memory index tree' (duration: 320.727053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:49:57.68824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:49:57.366473Z","time spent":"321.758858ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-07T00:50:03.062224Z","caller":"traceutil/trace.go:171","msg":"trace[1938031879] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"100.360012ms","start":"2026-05-07T00:50:02.961837Z","end":"2026-05-07T00:50:03.062197Z","steps":["trace[1938031879] 'process raft request' (duration: 100.176328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:03.313085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.182243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-07T00:50:03.31318Z","caller":"traceutil/trace.go:171","msg":"trace[291458785] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1008; }","duration":"120.328936ms","start":"2026-05-07T00:50:03.192827Z","end":"2026-05-07T00:50:03.313156Z","steps":["trace[291458785] 'count revisions from in-memory index tree' (duration: 120.08013ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:04.131605Z","caller":"traceutil/trace.go:171","msg":"trace[1467668757] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"411.883722ms","start":"2026-05-07T00:50:03.719692Z","end":"2026-05-07T00:50:04.131576Z","steps":["trace[1467668757] 'process raft request' (duration: 411.749989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:04.131752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:03.719678Z","time spent":"412.002215ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:50:04.622435Z","caller":"traceutil/trace.go:171","msg":"trace[826068970] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1045; }","duration":"895.473183ms","start":"2026-05-07T00:50:03.726926Z","end":"2026-05-07T00:50:04.622399Z","steps":["trace[826068970] 'read index received' (duration: 404.518834ms)","trace[826068970] 'applied index is now lower than readState.Index' (duration: 490.952849ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:50:04.622479Z","caller":"traceutil/trace.go:171","msg":"trace[1979223323] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"900.889214ms","start":"2026-05-07T00:50:03.721561Z","end":"2026-05-07T00:50:04.622451Z","steps":["trace[1979223323] 'process raft request' (duration: 857.361829ms)","trace[1979223323] 'compare' (duration: 43.178107ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:50:04.622594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:03.721533Z","time spent":"900.978887ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:50:04.622619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.445213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:50:04.622685Z","caller":"traceutil/trace.go:171","msg":"trace[477945249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1010; }","duration":"534.561825ms","start":"2026-05-07T00:50:04.088105Z","end":"2026-05-07T00:50:04.622667Z","steps":["trace[477945249] 'agreement among raft nodes before linearized reading' (duration: 534.462803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:04.622692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.305171ms","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-05-07T00:50:04.622675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.72522ms","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-05-07T00:50:04.622754Z","caller":"traceutil/trace.go:171","msg":"trace[1937222673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1010; }","duration":"893.364253ms","start":"2026-05-07T00:50:03.729356Z","end":"2026-05-07T00:50:04.62272Z","steps":["trace[1937222673] 'agreement among raft nodes before linearized reading' (duration: 893.198829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:04.622756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:04.088084Z","time spent":"534.632978ms","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T00:50:04.622789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:03.729347Z","time spent":"893.433904ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-07T00:50:04.62279Z","caller":"traceutil/trace.go:171","msg":"trace[461033525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1010; }","duration":"895.873503ms","start":"2026-05-07T00:50:03.726889Z","end":"2026-05-07T00:50:04.622763Z","steps":["trace[461033525] 'agreement among raft nodes before linearized reading' (duration: 895.632377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:04.622836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:03.726871Z","time spent":"895.955305ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-07T00:50:04.623027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.598188ms","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-05-07T00:50:04.623057Z","caller":"traceutil/trace.go:171","msg":"trace[656634461] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1010; }","duration":"893.65072ms","start":"2026-05-07T00:50:03.729397Z","end":"2026-05-07T00:50:04.623048Z","steps":["trace[656634461] 'agreement among raft nodes before linearized reading' (duration: 893.542407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:04.623085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:03.729386Z","time spent":"893.69352ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-07T00:50:05.459686Z","caller":"traceutil/trace.go:171","msg":"trace[21572363] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"833.413889ms","start":"2026-05-07T00:50:04.626244Z","end":"2026-05-07T00:50:05.459658Z","steps":["trace[21572363] 'process raft request' (duration: 833.148773ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:05.459852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:04.626228Z","time spent":"833.539322ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:50:05.461472Z","caller":"traceutil/trace.go:171","msg":"trace[646366732] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"834.916416ms","start":"2026-05-07T00:50:04.626536Z","end":"2026-05-07T00:50:05.461453Z","steps":["trace[646366732] 'process raft request' (duration: 834.782872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:05.461609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:04.626518Z","time spent":"835.036208ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:50:05.461679Z","caller":"traceutil/trace.go:171","msg":"trace[266343240] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"834.25584ms","start":"2026-05-07T00:50:04.627406Z","end":"2026-05-07T00:50:05.461662Z","steps":["trace[266343240] 'process raft request' (duration: 834.008234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:05.461771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:04.627387Z","time spent":"834.340421ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:50:05.461866Z","caller":"traceutil/trace.go:171","msg":"trace[1606846974] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"394.44696ms","start":"2026-05-07T00:50:05.067408Z","end":"2026-05-07T00:50:05.461855Z","steps":["trace[1606846974] 'process raft request' (duration: 394.200934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:05.461922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:05.067383Z","time spent":"394.509861ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:50:17.723657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.692173ms","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-05-07T00:50:17.723735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.068953ms","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-05-07T00:50:17.72377Z","caller":"traceutil/trace.go:171","msg":"trace[913245884] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1052; }","duration":"143.830326ms","start":"2026-05-07T00:50:17.579908Z","end":"2026-05-07T00:50:17.723738Z","steps":["trace[913245884] 'range keys from in-memory index tree' (duration: 143.537339ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:17.72382Z","caller":"traceutil/trace.go:171","msg":"trace[2012432705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1052; }","duration":"149.205186ms","start":"2026-05-07T00:50:17.574591Z","end":"2026-05-07T00:50:17.723796Z","steps":["trace[2012432705] 'range keys from in-memory index tree' (duration: 148.897789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:17.724232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.494973ms","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-05-07T00:50:17.724338Z","caller":"traceutil/trace.go:171","msg":"trace[1592259051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1052; }","duration":"149.649037ms","start":"2026-05-07T00:50:17.574662Z","end":"2026-05-07T00:50:17.724311Z","steps":["trace[1592259051] 'range keys from in-memory index tree' (duration: 149.193056ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:17.830623Z","caller":"traceutil/trace.go:171","msg":"trace[1727099250] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"103.299373ms","start":"2026-05-07T00:50:17.7273Z","end":"2026-05-07T00:50:17.8306Z","steps":["trace[1727099250] 'process raft request' (duration: 103.165ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:17.868113Z","caller":"traceutil/trace.go:171","msg":"trace[1299234973] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"139.389859ms","start":"2026-05-07T00:50:17.728692Z","end":"2026-05-07T00:50:17.868082Z","steps":["trace[1299234973] 'process raft request' (duration: 139.334297ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:17.868192Z","caller":"traceutil/trace.go:171","msg":"trace[1208864978] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"140.567996ms","start":"2026-05-07T00:50:17.727589Z","end":"2026-05-07T00:50:17.868157Z","steps":["trace[1208864978] 'process raft request' (duration: 140.273969ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:26.005465Z","caller":"traceutil/trace.go:171","msg":"trace[89703403] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"105.669502ms","start":"2026-05-07T00:50:25.899772Z","end":"2026-05-07T00:50:26.005442Z","steps":["trace[89703403] 'process raft request' (duration: 105.533488ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:26.005675Z","caller":"traceutil/trace.go:171","msg":"trace[1370059766] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1122; }","duration":"105.564379ms","start":"2026-05-07T00:50:25.900098Z","end":"2026-05-07T00:50:26.005663Z","steps":["trace[1370059766] 'read index received' (duration: 105.558949ms)","trace[1370059766] 'applied index is now lower than readState.Index' (duration: 4.49µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:50:26.005818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.711722ms","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-05-07T00:50:26.005857Z","caller":"traceutil/trace.go:171","msg":"trace[1176154652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1080; }","duration":"105.763914ms","start":"2026-05-07T00:50:25.900084Z","end":"2026-05-07T00:50:26.005848Z","steps":["trace[1176154652] 'agreement among raft nodes before linearized reading' (duration: 105.62396ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:26.736404Z","caller":"traceutil/trace.go:171","msg":"trace[1748939679] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"162.835047ms","start":"2026-05-07T00:50:26.573546Z","end":"2026-05-07T00:50:26.736381Z","steps":["trace[1748939679] 'process raft request' (duration: 162.691854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:26.956034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.594803ms","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-05-07T00:50:26.956107Z","caller":"traceutil/trace.go:171","msg":"trace[911757156] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1083; }","duration":"153.719326ms","start":"2026-05-07T00:50:26.80237Z","end":"2026-05-07T00:50:26.95609Z","steps":["trace[911757156] 'range keys from in-memory index tree' (duration: 153.361137ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:28.323432Z","caller":"traceutil/trace.go:171","msg":"trace[287199937] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1127; }","duration":"314.539183ms","start":"2026-05-07T00:50:28.008871Z","end":"2026-05-07T00:50:28.32341Z","steps":["trace[287199937] 'read index received' (duration: 314.310907ms)","trace[287199937] 'applied index is now lower than readState.Index' (duration: 227.226µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:50:28.323831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.943873ms","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-05-07T00:50:28.323831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.933497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:50:28.323878Z","caller":"traceutil/trace.go:171","msg":"trace[241862987] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1086; }","duration":"315.048376ms","start":"2026-05-07T00:50:28.008818Z","end":"2026-05-07T00:50:28.323866Z","steps":["trace[241862987] 'agreement among raft nodes before linearized reading' (duration: 314.722948ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:28.323889Z","caller":"traceutil/trace.go:171","msg":"trace[1364304725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1086; }","duration":"237.998078ms","start":"2026-05-07T00:50:28.085878Z","end":"2026-05-07T00:50:28.323876Z","steps":["trace[1364304725] 'agreement among raft nodes before linearized reading' (duration: 237.897746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:28.323901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.658827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-07T00:50:28.32406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:28.008799Z","time spent":"315.24625ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-07T00:50:28.323489Z","caller":"traceutil/trace.go:171","msg":"trace[591093770] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"420.306387ms","start":"2026-05-07T00:50:27.903151Z","end":"2026-05-07T00:50:28.323457Z","steps":["trace[591093770] 'process raft request' (duration: 420.124523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:28.32434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:27.903109Z","time spent":"421.135847ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:50:28.324745Z","caller":"traceutil/trace.go:171","msg":"trace[1439100845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1086; }","duration":"307.803879ms","start":"2026-05-07T00:50:28.016172Z","end":"2026-05-07T00:50:28.323976Z","steps":["trace[1439100845] 'agreement among raft nodes before linearized reading' (duration: 307.481712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:28.324804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:28.016156Z","time spent":"308.6328ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-07T00:50:29.588228Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532216031537438,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-07T00:50:29.729905Z","caller":"traceutil/trace.go:171","msg":"trace[1737800222] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1131; }","duration":"642.378049ms","start":"2026-05-07T00:50:29.087505Z","end":"2026-05-07T00:50:29.729883Z","steps":["trace[1737800222] 'read index received' (duration: 642.298217ms)","trace[1737800222] 'applied index is now lower than readState.Index' (duration: 78.952µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:50:29.729999Z","caller":"traceutil/trace.go:171","msg":"trace[319762465] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"724.894479ms","start":"2026-05-07T00:50:29.005096Z","end":"2026-05-07T00:50:29.72999Z","steps":["trace[319762465] 'process raft request' (duration: 724.657293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:29.730092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:29.00508Z","time spent":"724.94119ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:50:29.730594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.087876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:50:29.730722Z","caller":"traceutil/trace.go:171","msg":"trace[1941969275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1090; }","duration":"643.253341ms","start":"2026-05-07T00:50:29.087453Z","end":"2026-05-07T00:50:29.730706Z","steps":["trace[1941969275] 'agreement among raft nodes before linearized reading' (duration: 642.633766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:29.730822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:29.087434Z","time spent":"643.373563ms","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T00:50:29.773662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.673048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:50:29.773744Z","caller":"traceutil/trace.go:171","msg":"trace[379330961] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"181.751885ms","start":"2026-05-07T00:50:29.591966Z","end":"2026-05-07T00:50:29.773718Z","steps":["trace[379330961] 'process raft request' (duration: 181.377316ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:29.774073Z","caller":"traceutil/trace.go:171","msg":"trace[1945017023] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1091; }","duration":"378.852622ms","start":"2026-05-07T00:50:29.39494Z","end":"2026-05-07T00:50:29.773793Z","steps":["trace[1945017023] 'agreement among raft nodes before linearized reading' (duration: 378.625347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:29.77419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:29.394919Z","time spent":"379.250121ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:50:30.454218Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532216031537443,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-07T00:50:30.581994Z","caller":"traceutil/trace.go:171","msg":"trace[1218496783] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"628.020971ms","start":"2026-05-07T00:50:29.953949Z","end":"2026-05-07T00:50:30.58197Z","steps":["trace[1218496783] 'read index received' (duration: 627.338304ms)","trace[1218496783] 'applied index is now lower than readState.Index' (duration: 681.627µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:50:30.582103Z","caller":"traceutil/trace.go:171","msg":"trace[415564745] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"750.461428ms","start":"2026-05-07T00:50:29.831631Z","end":"2026-05-07T00:50:30.582093Z","steps":["trace[415564745] 'process raft request' (duration: 749.708079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:30.582266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:29.8316Z","time spent":"750.55778ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:50:30.582651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.32645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:50:30.582758Z","caller":"traceutil/trace.go:171","msg":"trace[1867975255] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1092; }","duration":"494.482324ms","start":"2026-05-07T00:50:30.088253Z","end":"2026-05-07T00:50:30.582735Z","steps":["trace[1867975255] 'agreement among raft nodes before linearized reading' (duration: 494.29331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:30.582816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.352267ms","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":"warn","ts":"2026-05-07T00:50:30.582832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:30.088227Z","time spent":"494.575327ms","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-07T00:50:30.582889Z","caller":"traceutil/trace.go:171","msg":"trace[1652970438] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1092; }","duration":"231.401988ms","start":"2026-05-07T00:50:30.35145Z","end":"2026-05-07T00:50:30.582852Z","steps":["trace[1652970438] 'agreement among raft nodes before linearized reading' (duration: 231.195073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:30.582845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.890681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T00:50:30.582884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.928607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-07T00:50:30.582945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.380738ms","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-05-07T00:50:30.582977Z","caller":"traceutil/trace.go:171","msg":"trace[266152950] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1092; }","duration":"629.032005ms","start":"2026-05-07T00:50:29.953896Z","end":"2026-05-07T00:50:30.582928Z","steps":["trace[266152950] 'agreement among raft nodes before linearized reading' (duration: 628.84666ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:30.583018Z","caller":"traceutil/trace.go:171","msg":"trace[453623043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1092; }","duration":"231.518201ms","start":"2026-05-07T00:50:30.351483Z","end":"2026-05-07T00:50:30.583001Z","steps":["trace[453623043] 'agreement among raft nodes before linearized reading' (duration: 231.265915ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:30.583009Z","caller":"traceutil/trace.go:171","msg":"trace[413841069] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1092; }","duration":"236.075611ms","start":"2026-05-07T00:50:30.346916Z","end":"2026-05-07T00:50:30.582992Z","steps":["trace[413841069] 'agreement among raft nodes before linearized reading' (duration: 235.850046ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:30.583103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:29.953874Z","time spent":"629.177489ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:50:30.583242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.544065ms","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-05-07T00:50:30.583308Z","caller":"traceutil/trace.go:171","msg":"trace[1553164901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1092; }","duration":"253.646528ms","start":"2026-05-07T00:50:30.32965Z","end":"2026-05-07T00:50:30.583296Z","steps":["trace[1553164901] 'agreement among raft nodes before linearized reading' (duration: 253.488144ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:32.459234Z","caller":"traceutil/trace.go:171","msg":"trace[1255409812] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"720.965423ms","start":"2026-05-07T00:50:31.738244Z","end":"2026-05-07T00:50:32.45921Z","steps":["trace[1255409812] 'process raft request' (duration: 720.82699ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:32.459395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:31.738219Z","time spent":"721.104017ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:50:33.130043Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532216031537454,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T00:50:33.631012Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532216031537454,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T00:50:33.671135Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.211657001s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-07T00:50:33.803128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.719192ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T00:50:33.803229Z","caller":"traceutil/trace.go:171","msg":"trace[401137156] linearizableReadLoop","detail":"{readStateIndex:1141; appliedIndex:1140; }","duration":"1.173289302s","start":"2026-05-07T00:50:32.629924Z","end":"2026-05-07T00:50:33.803213Z","steps":["trace[401137156] 'read index received' (duration: 1.041310134s)","trace[401137156] 'applied index is now lower than readState.Index' (duration: 131.977688ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:50:33.803269Z","caller":"traceutil/trace.go:171","msg":"trace[384864800] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"2.023732414s","start":"2026-05-07T00:50:31.779496Z","end":"2026-05-07T00:50:33.803228Z","steps":["trace[384864800] 'process raft request' (duration: 1.891828998s)","trace[384864800] 'compare' (duration: 131.350403ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:50:33.803443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:31.779478Z","time spent":"2.023876737s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:50:33.80344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.173508718s","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-05-07T00:50:33.803514Z","caller":"traceutil/trace.go:171","msg":"trace[1384557296] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1098; }","duration":"1.173587149s","start":"2026-05-07T00:50:32.62991Z","end":"2026-05-07T00:50:33.803497Z","steps":["trace[1384557296] 'agreement among raft nodes before linearized reading' (duration: 1.173357214s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:33.803571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:32.629842Z","time spent":"1.173716152s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-07T00:50:33.803733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.730685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-07T00:50:33.803762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156134135s","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-05-07T00:50:33.803861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.929485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:50:33.80391Z","caller":"traceutil/trace.go:171","msg":"trace[685517889] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1098; }","duration":"716.013767ms","start":"2026-05-07T00:50:33.087884Z","end":"2026-05-07T00:50:33.803898Z","steps":["trace[685517889] 'agreement among raft nodes before linearized reading' (duration: 715.942865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:33.803949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:33.087863Z","time spent":"716.075668ms","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-07T00:50:33.803877Z","caller":"traceutil/trace.go:171","msg":"trace[1881120535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1098; }","duration":"1.156285979s","start":"2026-05-07T00:50:32.647575Z","end":"2026-05-07T00:50:33.803861Z","steps":["trace[1881120535] 'agreement among raft nodes before linearized reading' (duration: 1.155783017s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:33.804051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043730982s","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-05-07T00:50:33.804113Z","caller":"traceutil/trace.go:171","msg":"trace[1938295652] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1098; }","duration":"1.043859485s","start":"2026-05-07T00:50:32.76024Z","end":"2026-05-07T00:50:33.804099Z","steps":["trace[1938295652] 'agreement among raft nodes before linearized reading' (duration: 1.043733512s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:33.804165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:32.760213Z","time spent":"1.043937437s","remote":"127.0.0.1:55754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:50:33.804099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:32.647557Z","time spent":"1.156484383s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T00:50:33.804344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156669668s","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-05-07T00:50:33.804401Z","caller":"traceutil/trace.go:171","msg":"trace[503888761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1098; }","duration":"1.15674642s","start":"2026-05-07T00:50:32.647641Z","end":"2026-05-07T00:50:33.804387Z","steps":["trace[503888761] 'agreement among raft nodes before linearized reading' (duration: 1.156610826s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:33.804441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:32.647634Z","time spent":"1.156797152s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-07T00:50:33.803784Z","caller":"traceutil/trace.go:171","msg":"trace[337464782] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1098; }","duration":"205.783936ms","start":"2026-05-07T00:50:33.597987Z","end":"2026-05-07T00:50:33.803771Z","steps":["trace[337464782] 'agreement among raft nodes before linearized reading' (duration: 205.706164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:33.803472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.009404058s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:50:33.804639Z","caller":"traceutil/trace.go:171","msg":"trace[1411660571] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1098; }","duration":"1.010606427s","start":"2026-05-07T00:50:32.794017Z","end":"2026-05-07T00:50:33.804624Z","steps":["trace[1411660571] 'agreement among raft nodes before linearized reading' (duration: 1.009397048s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:33.804694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:32.794005Z","time spent":"1.010673038s","remote":"127.0.0.1:55632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:50:33.804367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156403962s","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-05-07T00:50:33.806174Z","caller":"traceutil/trace.go:171","msg":"trace[1521958589] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1098; }","duration":"1.158229805s","start":"2026-05-07T00:50:32.647927Z","end":"2026-05-07T00:50:33.806157Z","steps":["trace[1521958589] 'agreement among raft nodes before linearized reading' (duration: 1.155931501s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:33.806229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:32.647919Z","time spent":"1.158291477s","remote":"127.0.0.1:55596","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-05-07T00:50:33.970297Z","caller":"traceutil/trace.go:171","msg":"trace[1732839239] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"158.657049ms","start":"2026-05-07T00:50:33.811614Z","end":"2026-05-07T00:50:33.970271Z","steps":["trace[1732839239] 'process raft request' (duration: 120.476204ms)","trace[1732839239] 'compare' (duration: 37.97443ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:50:33.970744Z","caller":"traceutil/trace.go:171","msg":"trace[1228535204] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"159.07972ms","start":"2026-05-07T00:50:33.811637Z","end":"2026-05-07T00:50:33.970717Z","steps":["trace[1228535204] 'process raft request' (duration: 158.591108ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:33.971081Z","caller":"traceutil/trace.go:171","msg":"trace[477528187] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"159.312235ms","start":"2026-05-07T00:50:33.811757Z","end":"2026-05-07T00:50:33.971069Z","steps":["trace[477528187] 'process raft request' (duration: 158.68403ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:33.971085Z","caller":"traceutil/trace.go:171","msg":"trace[635432697] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"158.539807ms","start":"2026-05-07T00:50:33.812514Z","end":"2026-05-07T00:50:33.971054Z","steps":["trace[635432697] 'process raft request' (duration: 158.419794ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:34.576069Z","caller":"traceutil/trace.go:171","msg":"trace[156835837] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"110.453277ms","start":"2026-05-07T00:50:34.465596Z","end":"2026-05-07T00:50:34.576049Z","steps":["trace[156835837] 'process raft request' (duration: 110.315483ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:36.122668Z","caller":"traceutil/trace.go:171","msg":"trace[1925004487] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1148; }","duration":"147.752161ms","start":"2026-05-07T00:50:35.974889Z","end":"2026-05-07T00:50:36.122641Z","steps":["trace[1925004487] 'read index received' (duration: 147.533295ms)","trace[1925004487] 'applied index is now lower than readState.Index' (duration: 217.705µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:50:36.123022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.098899ms","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-05-07T00:50:36.123082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.797382ms","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-05-07T00:50:36.123131Z","caller":"traceutil/trace.go:171","msg":"trace[1578872397] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1105; }","duration":"148.252022ms","start":"2026-05-07T00:50:35.974847Z","end":"2026-05-07T00:50:36.123099Z","steps":["trace[1578872397] 'agreement among raft nodes before linearized reading' (duration: 147.960575ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:36.123156Z","caller":"traceutil/trace.go:171","msg":"trace[1009123428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1105; }","duration":"147.921065ms","start":"2026-05-07T00:50:35.975214Z","end":"2026-05-07T00:50:36.123135Z","steps":["trace[1009123428] 'agreement among raft nodes before linearized reading' (duration: 147.71976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:36.123276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.910864ms","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-05-07T00:50:36.122823Z","caller":"traceutil/trace.go:171","msg":"trace[1719490092] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"312.398202ms","start":"2026-05-07T00:50:35.810378Z","end":"2026-05-07T00:50:36.122776Z","steps":["trace[1719490092] 'process raft request' (duration: 312.077044ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:36.12335Z","caller":"traceutil/trace.go:171","msg":"trace[628659268] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1105; }","duration":"148.049358ms","start":"2026-05-07T00:50:35.975283Z","end":"2026-05-07T00:50:36.123332Z","steps":["trace[628659268] 'agreement among raft nodes before linearized reading' (duration: 147.72696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:36.123423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.035907ms","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-05-07T00:50:36.123505Z","caller":"traceutil/trace.go:171","msg":"trace[72471639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1105; }","duration":"148.247693ms","start":"2026-05-07T00:50:35.975242Z","end":"2026-05-07T00:50:36.12349Z","steps":["trace[72471639] 'agreement among raft nodes before linearized reading' (duration: 147.800842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:36.123438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:35.810353Z","time spent":"313.011817ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:50:36.28999Z","caller":"traceutil/trace.go:171","msg":"trace[2073110379] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"161.581908ms","start":"2026-05-07T00:50:36.128376Z","end":"2026-05-07T00:50:36.289958Z","steps":["trace[2073110379] 'process raft request' (duration: 145.714742ms)","trace[2073110379] 'compare' (duration: 15.715483ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:50:36.554339Z","caller":"traceutil/trace.go:171","msg":"trace[1504836579] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"425.680726ms","start":"2026-05-07T00:50:36.128628Z","end":"2026-05-07T00:50:36.554308Z","steps":["trace[1504836579] 'process raft request' (duration: 425.572584ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:36.554387Z","caller":"traceutil/trace.go:171","msg":"trace[1976277648] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"425.719108ms","start":"2026-05-07T00:50:36.128621Z","end":"2026-05-07T00:50:36.55434Z","steps":["trace[1976277648] 'process raft request' (duration: 380.338343ms)","trace[1976277648] 'compare' (duration: 45.041537ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:50:36.554524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:36.128568Z","time spent":"425.865611ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:50:36.5547Z","caller":"traceutil/trace.go:171","msg":"trace[1450207186] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"425.994775ms","start":"2026-05-07T00:50:36.128662Z","end":"2026-05-07T00:50:36.554657Z","steps":["trace[1450207186] 'process raft request' (duration: 425.602835ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:36.55477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:36.128608Z","time spent":"425.863991ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:50:36.554864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:36.128643Z","time spent":"426.130647ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:50:36.748728Z","caller":"traceutil/trace.go:171","msg":"trace[217460200] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"163.898704ms","start":"2026-05-07T00:50:36.58478Z","end":"2026-05-07T00:50:36.748679Z","steps":["trace[217460200] 'process raft request' (duration: 103.222156ms)","trace[217460200] 'compare' (duration: 60.32256ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:50:42.398571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.187084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:50:42.398665Z","caller":"traceutil/trace.go:171","msg":"trace[1918897843] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1125; }","duration":"100.394199ms","start":"2026-05-07T00:50:42.298247Z","end":"2026-05-07T00:50:42.398641Z","steps":["trace[1918897843] 'count revisions from in-memory index tree' (duration: 100.093791ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:42.594177Z","caller":"traceutil/trace.go:171","msg":"trace[1213145493] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"191.1686ms","start":"2026-05-07T00:50:42.402946Z","end":"2026-05-07T00:50:42.594115Z","steps":["trace[1213145493] 'process raft request' (duration: 190.990695ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:42.730618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.051942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T00:50:42.730807Z","caller":"traceutil/trace.go:171","msg":"trace[1940365459] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"131.010294ms","start":"2026-05-07T00:50:42.59978Z","end":"2026-05-07T00:50:42.73079Z","steps":["trace[1940365459] 'process raft request' (duration: 130.978094ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:42.730828Z","caller":"traceutil/trace.go:171","msg":"trace[1435560798] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"131.993188ms","start":"2026-05-07T00:50:42.598809Z","end":"2026-05-07T00:50:42.730803Z","steps":["trace[1435560798] 'compare' (duration: 121.9396ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:42.730993Z","caller":"traceutil/trace.go:171","msg":"trace[241079085] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"131.790513ms","start":"2026-05-07T00:50:42.599191Z","end":"2026-05-07T00:50:42.730982Z","steps":["trace[241079085] 'process raft request' (duration: 131.525707ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:48.855016Z","caller":"traceutil/trace.go:171","msg":"trace[237997747] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"231.993987ms","start":"2026-05-07T00:50:48.623001Z","end":"2026-05-07T00:50:48.854995Z","steps":["trace[237997747] 'process raft request' (duration: 231.833233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:50.116102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.799148ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T00:50:50.116218Z","caller":"traceutil/trace.go:171","msg":"trace[859027295] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"1.257513826s","start":"2026-05-07T00:50:48.858683Z","end":"2026-05-07T00:50:50.116197Z","steps":["trace[859027295] 'process raft request' (duration: 363.526244ms)","trace[859027295] 'compare' (duration: 893.170013ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:50:50.116325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:48.858663Z","time spent":"1.257593359s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:50:50.261779Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.039610613s","expected-duration":"1s"} {"level":"info","ts":"2026-05-07T00:50:50.26226Z","caller":"traceutil/trace.go:171","msg":"trace[553260778] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"1.402682946s","start":"2026-05-07T00:50:48.859544Z","end":"2026-05-07T00:50:50.262227Z","steps":["trace[553260778] 'process raft request' (duration: 1.40239054s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:50.262429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:48.859528Z","time spent":"1.402814859s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:50:50.262446Z","caller":"traceutil/trace.go:171","msg":"trace[2076653631] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"1.401869408s","start":"2026-05-07T00:50:48.860532Z","end":"2026-05-07T00:50:50.262402Z","steps":["trace[2076653631] 'process raft request' (duration: 1.401571521s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:50.262621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:48.860517Z","time spent":"1.402006741s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:50:50.26433Z","caller":"traceutil/trace.go:171","msg":"trace[929428816] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"1.40368871s","start":"2026-05-07T00:50:48.860598Z","end":"2026-05-07T00:50:50.264286Z","steps":["trace[929428816] 'process raft request' (duration: 1.403210969s)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:50.264372Z","caller":"traceutil/trace.go:171","msg":"trace[777024961] linearizableReadLoop","detail":"{readStateIndex:1249; appliedIndex:1245; }","duration":"1.175156655s","start":"2026-05-07T00:50:49.089196Z","end":"2026-05-07T00:50:50.264352Z","steps":["trace[777024961] 'read index received' (duration: 132.981911ms)","trace[777024961] 'applied index is now lower than readState.Index' (duration: 1.042172474s)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:50:50.26446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:48.860591Z","time spent":"1.403796173s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:50:50.264486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.175294769s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T00:50:50.264508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.162890575s","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-05-07T00:50:50.264518Z","caller":"traceutil/trace.go:171","msg":"trace[558206508] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1202; }","duration":"1.175373491s","start":"2026-05-07T00:50:49.089137Z","end":"2026-05-07T00:50:50.264511Z","steps":["trace[558206508] 'agreement among raft nodes before linearized reading' (duration: 1.175312849s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:50.264541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:49.089116Z","time spent":"1.175421771s","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-07T00:50:50.264541Z","caller":"traceutil/trace.go:171","msg":"trace[2048033427] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1202; }","duration":"1.162940896s","start":"2026-05-07T00:50:49.101591Z","end":"2026-05-07T00:50:50.264532Z","steps":["trace[2048033427] 'agreement among raft nodes before linearized reading' (duration: 1.162870764s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:50.264567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:49.101533Z","time spent":"1.163026918s","remote":"127.0.0.1:34574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-07T00:50:51.359841Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532216031537690,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T00:50:52.136596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.016562ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-07T00:50:52.13686Z","caller":"traceutil/trace.go:171","msg":"trace[1330868642] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1250; }","duration":"1.277268746s","start":"2026-05-07T00:50:50.859573Z","end":"2026-05-07T00:50:52.136842Z","steps":["trace[1330868642] 'read index received' (duration: 767.992328ms)","trace[1330868642] 'applied index is now lower than readState.Index' (duration: 509.275408ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:50:52.136942Z","caller":"traceutil/trace.go:171","msg":"trace[2046440861] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"854.409326ms","start":"2026-05-07T00:50:51.282523Z","end":"2026-05-07T00:50:52.136932Z","steps":["trace[2046440861] 'process raft request' (duration: 854.171381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:52.137021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:51.282497Z","time spent":"854.465887ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:50:52.13708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.791776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-07T00:50:52.13731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.277726847s","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-05-07T00:50:52.137356Z","caller":"traceutil/trace.go:171","msg":"trace[1890870433] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1203; }","duration":"1.277801508s","start":"2026-05-07T00:50:50.859544Z","end":"2026-05-07T00:50:52.137345Z","steps":["trace[1890870433] 'agreement among raft nodes before linearized reading' (duration: 1.277653985s)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:50:52.137361Z","caller":"traceutil/trace.go:171","msg":"trace[1828923814] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1203; }","duration":"923.087304ms","start":"2026-05-07T00:50:51.214243Z","end":"2026-05-07T00:50:52.13733Z","steps":["trace[1828923814] 'agreement among raft nodes before linearized reading' (duration: 922.750726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:50:52.137379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:50.859531Z","time spent":"1.27784474s","remote":"127.0.0.1:55596","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-05-07T00:50:52.137411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:50:51.214195Z","time spent":"923.200796ms","remote":"127.0.0.1:55806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":31,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-05-07T00:51:07.988222Z","caller":"traceutil/trace.go:171","msg":"trace[802514414] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"206.921204ms","start":"2026-05-07T00:51:07.781283Z","end":"2026-05-07T00:51:07.988205Z","steps":["trace[802514414] 'process raft request' (duration: 206.818811ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:08.507989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.844334ms","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-05-07T00:51:08.508055Z","caller":"traceutil/trace.go:171","msg":"trace[301645841] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1264; }","duration":"304.954997ms","start":"2026-05-07T00:51:08.203085Z","end":"2026-05-07T00:51:08.508041Z","steps":["trace[301645841] 'range keys from in-memory index tree' (duration: 304.69423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:08.508086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:08.203065Z","time spent":"305.014958ms","remote":"127.0.0.1:55596","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-05-07T00:51:08.508181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.332283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:51:08.508241Z","caller":"traceutil/trace.go:171","msg":"trace[1186699393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1264; }","duration":"421.427076ms","start":"2026-05-07T00:51:08.086799Z","end":"2026-05-07T00:51:08.508226Z","steps":["trace[1186699393] 'range keys from in-memory index tree' (duration: 421.226781ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:08.508267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:08.086785Z","time spent":"421.476757ms","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T00:51:08.508377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.722376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-07T00:51:08.508476Z","caller":"traceutil/trace.go:171","msg":"trace[1590424401] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1264; }","duration":"300.857199ms","start":"2026-05-07T00:51:08.207596Z","end":"2026-05-07T00:51:08.508453Z","steps":["trace[1590424401] 'range keys from in-memory index tree' (duration: 300.518661ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:08.508465Z","caller":"traceutil/trace.go:171","msg":"trace[1935342411] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"181.89022ms","start":"2026-05-07T00:51:08.326543Z","end":"2026-05-07T00:51:08.508433Z","steps":["trace[1935342411] 'process raft request' (duration: 133.718648ms)","trace[1935342411] 'compare' (duration: 47.622349ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:51:08.50855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:08.207584Z","time spent":"300.934631ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-07T00:51:08.508358Z","caller":"traceutil/trace.go:171","msg":"trace[1624633522] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1316; }","duration":"151.93722ms","start":"2026-05-07T00:51:08.3564Z","end":"2026-05-07T00:51:08.508337Z","steps":["trace[1624633522] 'read index received' (duration: 103.805009ms)","trace[1624633522] 'applied index is now lower than readState.Index' (duration: 48.131341ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:51:08.508694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.302359ms","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-05-07T00:51:08.508743Z","caller":"traceutil/trace.go:171","msg":"trace[389340458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1265; }","duration":"152.390221ms","start":"2026-05-07T00:51:08.356339Z","end":"2026-05-07T00:51:08.50873Z","steps":["trace[389340458] 'agreement among raft nodes before linearized reading' (duration: 152.262628ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:08.508791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.675085ms","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-05-07T00:51:08.508821Z","caller":"traceutil/trace.go:171","msg":"trace[1726652388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1265; }","duration":"146.738427ms","start":"2026-05-07T00:51:08.362073Z","end":"2026-05-07T00:51:08.508812Z","steps":["trace[1726652388] 'agreement among raft nodes before linearized reading' (duration: 146.603334ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:08.508863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.761179ms","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-05-07T00:51:08.508913Z","caller":"traceutil/trace.go:171","msg":"trace[1063047654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1265; }","duration":"141.849961ms","start":"2026-05-07T00:51:08.367048Z","end":"2026-05-07T00:51:08.508898Z","steps":["trace[1063047654] 'agreement among raft nodes before linearized reading' (duration: 141.670037ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:10.849146Z","caller":"traceutil/trace.go:171","msg":"trace[1787826196] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"235.776396ms","start":"2026-05-07T00:51:10.613347Z","end":"2026-05-07T00:51:10.849123Z","steps":["trace[1787826196] 'process raft request' (duration: 235.611402ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:10.877347Z","caller":"traceutil/trace.go:171","msg":"trace[278398807] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"262.699764ms","start":"2026-05-07T00:51:10.614627Z","end":"2026-05-07T00:51:10.877327Z","steps":["trace[278398807] 'process raft request' (duration: 262.55409ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:10.877596Z","caller":"traceutil/trace.go:171","msg":"trace[1722068284] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"262.895788ms","start":"2026-05-07T00:51:10.614691Z","end":"2026-05-07T00:51:10.877587Z","steps":["trace[1722068284] 'process raft request' (duration: 262.606051ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:10.878224Z","caller":"traceutil/trace.go:171","msg":"trace[2114092838] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"263.287558ms","start":"2026-05-07T00:51:10.614914Z","end":"2026-05-07T00:51:10.878202Z","steps":["trace[2114092838] 'process raft request' (duration: 262.566611ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:10.87829Z","caller":"traceutil/trace.go:171","msg":"trace[1298989373] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"263.234946ms","start":"2026-05-07T00:51:10.615038Z","end":"2026-05-07T00:51:10.878273Z","steps":["trace[1298989373] 'process raft request' (duration: 262.879968ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:11.02402Z","caller":"traceutil/trace.go:171","msg":"trace[2114554511] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"128.621818ms","start":"2026-05-07T00:51:10.89537Z","end":"2026-05-07T00:51:11.023992Z","steps":["trace[2114554511] 'process raft request' (duration: 128.458974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:12.788265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.3484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-07T00:51:12.788506Z","caller":"traceutil/trace.go:171","msg":"trace[158167645] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1279; }","duration":"252.636717ms","start":"2026-05-07T00:51:12.535852Z","end":"2026-05-07T00:51:12.788489Z","steps":["trace[158167645] 'count revisions from in-memory index tree' (duration: 252.263657ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:12.790503Z","caller":"traceutil/trace.go:171","msg":"trace[1668948813] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"176.012181ms","start":"2026-05-07T00:51:12.614393Z","end":"2026-05-07T00:51:12.790405Z","steps":["trace[1668948813] 'process raft request' (duration: 135.205314ms)","trace[1668948813] 'compare' (duration: 38.269527ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:51:18.146703Z","caller":"traceutil/trace.go:171","msg":"trace[473995375] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"130.044992ms","start":"2026-05-07T00:51:18.016625Z","end":"2026-05-07T00:51:18.14667Z","steps":["trace[473995375] 'process raft request' (duration: 129.768435ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:21.069943Z","caller":"traceutil/trace.go:171","msg":"trace[1928400947] linearizableReadLoop","detail":"{readStateIndex:1413; appliedIndex:1412; }","duration":"188.968898ms","start":"2026-05-07T00:51:20.880948Z","end":"2026-05-07T00:51:21.069917Z","steps":["trace[1928400947] 'read index received' (duration: 188.64652ms)","trace[1928400947] 'applied index is now lower than readState.Index' (duration: 321.098µs)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:51:21.070232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.262065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-07T00:51:21.070275Z","caller":"traceutil/trace.go:171","msg":"trace[691774066] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1359; }","duration":"189.50194ms","start":"2026-05-07T00:51:20.880761Z","end":"2026-05-07T00:51:21.070263Z","steps":["trace[691774066] 'agreement among raft nodes before linearized reading' (duration: 189.298665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:21.070442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.550835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-07T00:51:21.070503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.175355ms","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-05-07T00:51:21.070547Z","caller":"traceutil/trace.go:171","msg":"trace[541522283] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1359; }","duration":"125.727959ms","start":"2026-05-07T00:51:20.944792Z","end":"2026-05-07T00:51:21.070519Z","steps":["trace[541522283] 'agreement among raft nodes before linearized reading' (duration: 125.440842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:21.070548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.170041ms","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-05-07T00:51:21.070565Z","caller":"traceutil/trace.go:171","msg":"trace[469262513] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1359; }","duration":"122.306388ms","start":"2026-05-07T00:51:20.948242Z","end":"2026-05-07T00:51:21.070548Z","steps":["trace[469262513] 'agreement among raft nodes before linearized reading' (duration: 122.146224ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:21.070612Z","caller":"traceutil/trace.go:171","msg":"trace[1205483692] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1359; }","duration":"121.284694ms","start":"2026-05-07T00:51:20.949314Z","end":"2026-05-07T00:51:21.070599Z","steps":["trace[1205483692] 'agreement among raft nodes before linearized reading' (duration: 120.927515ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:21.070078Z","caller":"traceutil/trace.go:171","msg":"trace[2119107045] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"250.026575ms","start":"2026-05-07T00:51:20.820021Z","end":"2026-05-07T00:51:21.070047Z","steps":["trace[2119107045] 'process raft request' (duration: 249.701677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:21.070812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.768315ms","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-05-07T00:51:21.070878Z","caller":"traceutil/trace.go:171","msg":"trace[1174965842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1359; }","duration":"121.850918ms","start":"2026-05-07T00:51:20.94899Z","end":"2026-05-07T00:51:21.070841Z","steps":["trace[1174965842] 'agreement among raft nodes before linearized reading' (duration: 121.273094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:21.586518Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976532216031538016,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T00:51:22.329043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.875035ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T00:51:22.329317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.355976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T00:51:22.329422Z","caller":"traceutil/trace.go:171","msg":"trace[1263605838] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"1.254451104s","start":"2026-05-07T00:51:21.074949Z","end":"2026-05-07T00:51:22.3294Z","steps":["trace[1263605838] 'process raft request' (duration: 799.924104ms)","trace[1263605838] 'compare' (duration: 454.187432ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:51:22.329519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:21.07493Z","time spent":"1.254541466s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:51:22.33008Z","caller":"traceutil/trace.go:171","msg":"trace[2084063560] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1359; }","duration":"124.07356ms","start":"2026-05-07T00:51:22.205125Z","end":"2026-05-07T00:51:22.329199Z","steps":["trace[2084063560] 'range keys from in-memory index tree' (duration: 123.858405ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:22.340926Z","caller":"traceutil/trace.go:171","msg":"trace[30912296] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"1.265511636s","start":"2026-05-07T00:51:21.075395Z","end":"2026-05-07T00:51:22.340907Z","steps":["trace[30912296] 'process raft request' (duration: 1.265039675s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:22.34101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:21.075384Z","time spent":"1.265584049s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:51:22.341165Z","caller":"traceutil/trace.go:171","msg":"trace[188066356] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"1.265704651s","start":"2026-05-07T00:51:21.075443Z","end":"2026-05-07T00:51:22.341147Z","steps":["trace[188066356] 'process raft request' (duration: 1.26523768s)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:22.341217Z","caller":"traceutil/trace.go:171","msg":"trace[261373673] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"1.265403674s","start":"2026-05-07T00:51:21.07579Z","end":"2026-05-07T00:51:22.341194Z","steps":["trace[261373673] 'process raft request' (duration: 1.265194969s)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:22.341258Z","caller":"traceutil/trace.go:171","msg":"trace[698285154] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"1.26523204s","start":"2026-05-07T00:51:21.076003Z","end":"2026-05-07T00:51:22.341235Z","steps":["trace[698285154] 'process raft request' (duration: 1.265041475s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:22.341306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:21.075421Z","time spent":"1.265781323s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:51:22.341368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:21.075781Z","time spent":"1.265494756s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T00:51:22.341397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:21.075984Z","time spent":"1.265343032s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:51:22.341283Z","caller":"traceutil/trace.go:171","msg":"trace[574464477] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"1.265521047s","start":"2026-05-07T00:51:21.075748Z","end":"2026-05-07T00:51:22.341269Z","steps":["trace[574464477] 'process raft request' (duration: 1.265067266s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:22.341534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:21.075737Z","time spent":"1.265764712s","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:51:22.348815Z","caller":"traceutil/trace.go:171","msg":"trace[498973906] linearizableReadLoop","detail":"{readStateIndex:1420; appliedIndex:1413; }","duration":"1.262852774s","start":"2026-05-07T00:51:21.08594Z","end":"2026-05-07T00:51:22.348793Z","steps":["trace[498973906] 'read index received' (duration: 788.823831ms)","trace[498973906] 'applied index is now lower than readState.Index' (duration: 474.026893ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:51:22.349148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116017524s","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":"warn","ts":"2026-05-07T00:51:22.349138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.263171681s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:51:22.349179Z","caller":"traceutil/trace.go:171","msg":"trace[751889446] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1365; }","duration":"1.116099486s","start":"2026-05-07T00:51:21.233071Z","end":"2026-05-07T00:51:22.349171Z","steps":["trace[751889446] 'agreement among raft nodes before linearized reading' (duration: 1.116025134s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:22.349612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:21.23305Z","time spent":"1.116541207s","remote":"127.0.0.1:55688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":31,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-05-07T00:51:22.349531Z","caller":"traceutil/trace.go:171","msg":"trace[728285203] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1365; }","duration":"1.263598892s","start":"2026-05-07T00:51:21.0859Z","end":"2026-05-07T00:51:22.349499Z","steps":["trace[728285203] 'agreement among raft nodes before linearized reading' (duration: 1.26312318s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:22.349896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:21.085887Z","time spent":"1.26397s","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T00:51:22.349245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.006248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:51:22.350203Z","caller":"traceutil/trace.go:171","msg":"trace[2110468001] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1365; }","duration":"260.009711ms","start":"2026-05-07T00:51:22.090175Z","end":"2026-05-07T00:51:22.350184Z","steps":["trace[2110468001] 'agreement among raft nodes before linearized reading' (duration: 259.052428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:22.349318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.633522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-07T00:51:22.350494Z","caller":"traceutil/trace.go:171","msg":"trace[1351113350] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1365; }","duration":"693.80237ms","start":"2026-05-07T00:51:21.656679Z","end":"2026-05-07T00:51:22.350481Z","steps":["trace[1351113350] 'agreement among raft nodes before linearized reading' (duration: 692.580881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:22.350801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:51:21.656617Z","time spent":"694.168079ms","remote":"127.0.0.1:55698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":70,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-05-07T00:51:32.578246Z","caller":"traceutil/trace.go:171","msg":"trace[112785702] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"105.266684ms","start":"2026-05-07T00:51:32.472948Z","end":"2026-05-07T00:51:32.578215Z","steps":["trace[112785702] 'process raft request' (duration: 60.072193ms)","trace[112785702] 'compare' (duration: 45.014107ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:51:32.705037Z","caller":"traceutil/trace.go:171","msg":"trace[1650066850] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"121.460968ms","start":"2026-05-07T00:51:32.583552Z","end":"2026-05-07T00:51:32.705013Z","steps":["trace[1650066850] 'process raft request' (duration: 121.422577ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:32.705406Z","caller":"traceutil/trace.go:171","msg":"trace[994700908] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"122.541663ms","start":"2026-05-07T00:51:32.582836Z","end":"2026-05-07T00:51:32.705377Z","steps":["trace[994700908] 'process raft request' (duration: 119.838439ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:32.705507Z","caller":"traceutil/trace.go:171","msg":"trace[928318986] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"122.458791ms","start":"2026-05-07T00:51:32.582959Z","end":"2026-05-07T00:51:32.705418Z","steps":["trace[928318986] 'process raft request' (duration: 121.96836ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:48.90611Z","caller":"traceutil/trace.go:171","msg":"trace[913636247] linearizableReadLoop","detail":"{readStateIndex:1544; appliedIndex:1543; }","duration":"123.350736ms","start":"2026-05-07T00:51:48.782724Z","end":"2026-05-07T00:51:48.906074Z","steps":["trace[913636247] 'read index received' (duration: 88.462345ms)","trace[913636247] 'applied index is now lower than readState.Index' (duration: 34.885651ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:51:48.906086Z","caller":"traceutil/trace.go:171","msg":"trace[1305196963] transaction","detail":"{read_only:false; response_revision:1484; number_of_response:1; }","duration":"123.510649ms","start":"2026-05-07T00:51:48.782545Z","end":"2026-05-07T00:51:48.906055Z","steps":["trace[1305196963] 'process raft request' (duration: 88.625149ms)","trace[1305196963] 'compare' (duration: 34.541252ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:51:48.906082Z","caller":"traceutil/trace.go:171","msg":"trace[888461972] transaction","detail":"{read_only:false; response_revision:1485; number_of_response:1; }","duration":"122.938666ms","start":"2026-05-07T00:51:48.783104Z","end":"2026-05-07T00:51:48.906043Z","steps":["trace[888461972] 'process raft request' (duration: 122.861954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:51:48.906411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.675013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-05-07T00:51:48.90634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.867338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-07T00:51:48.906459Z","caller":"traceutil/trace.go:171","msg":"trace[590824833] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1485; }","duration":"123.736805ms","start":"2026-05-07T00:51:48.782708Z","end":"2026-05-07T00:51:48.906445Z","steps":["trace[590824833] 'agreement among raft nodes before linearized reading' (duration: 123.55382ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:48.906487Z","caller":"traceutil/trace.go:171","msg":"trace[1417396578] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1485; }","duration":"115.015802ms","start":"2026-05-07T00:51:48.791445Z","end":"2026-05-07T00:51:48.906461Z","steps":["trace[1417396578] 'agreement among raft nodes before linearized reading' (duration: 114.844068ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:49.18248Z","caller":"traceutil/trace.go:171","msg":"trace[1082152735] transaction","detail":"{read_only:false; response_revision:1486; number_of_response:1; }","duration":"272.399048ms","start":"2026-05-07T00:51:48.910058Z","end":"2026-05-07T00:51:49.182457Z","steps":["trace[1082152735] 'process raft request' (duration: 272.279065ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:49.185412Z","caller":"traceutil/trace.go:171","msg":"trace[1488866199] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"274.979977ms","start":"2026-05-07T00:51:48.910415Z","end":"2026-05-07T00:51:49.185395Z","steps":["trace[1488866199] 'process raft request' (duration: 274.596418ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:49.18562Z","caller":"traceutil/trace.go:171","msg":"trace[1796279338] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"163.285543ms","start":"2026-05-07T00:51:49.022319Z","end":"2026-05-07T00:51:49.185605Z","steps":["trace[1796279338] 'process raft request' (duration: 162.776211ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:51:53.074156Z","caller":"traceutil/trace.go:171","msg":"trace[1699760304] linearizableReadLoop","detail":"{readStateIndex:1565; appliedIndex:1563; }","duration":"120.848487ms","start":"2026-05-07T00:51:52.95325Z","end":"2026-05-07T00:51:53.074098Z","steps":["trace[1699760304] 'read index received' (duration: 20.094016ms)","trace[1699760304] 'applied index is now lower than readState.Index' (duration: 100.753301ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:51:53.074272Z","caller":"traceutil/trace.go:171","msg":"trace[1959361719] transaction","detail":"{read_only:false; response_revision:1504; number_of_response:1; }","duration":"147.274571ms","start":"2026-05-07T00:51:52.926961Z","end":"2026-05-07T00:51:53.074235Z","steps":["trace[1959361719] 'process raft request' (duration: 106.212427ms)","trace[1959361719] 'compare' (duration: 40.757617ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:51:53.074316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.031532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:51:53.074353Z","caller":"traceutil/trace.go:171","msg":"trace[138283205] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1504; }","duration":"121.106213ms","start":"2026-05-07T00:51:52.953237Z","end":"2026-05-07T00:51:53.074343Z","steps":["trace[138283205] 'agreement among raft nodes before linearized reading' (duration: 121.014681ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:52:05.508003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.51032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-07T00:52:05.508101Z","caller":"traceutil/trace.go:171","msg":"trace[1903835516] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:1562; }","duration":"114.658513ms","start":"2026-05-07T00:52:05.393415Z","end":"2026-05-07T00:52:05.508074Z","steps":["trace[1903835516] 'range keys from in-memory index tree' (duration: 114.329836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:52:19.159982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.045022ms","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-05-07T00:52:19.160105Z","caller":"traceutil/trace.go:171","msg":"trace[675676781] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1620; }","duration":"124.207745ms","start":"2026-05-07T00:52:19.035866Z","end":"2026-05-07T00:52:19.160074Z","steps":["trace[675676781] 'range keys from in-memory index tree' (duration: 123.879777ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:52:21.354506Z","caller":"traceutil/trace.go:171","msg":"trace[1041023761] transaction","detail":"{read_only:false; response_revision:1633; number_of_response:1; }","duration":"101.700812ms","start":"2026-05-07T00:52:21.252761Z","end":"2026-05-07T00:52:21.354462Z","steps":["trace[1041023761] 'process raft request' (duration: 101.19069ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:53:01.329822Z","caller":"traceutil/trace.go:171","msg":"trace[625259867] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"210.722297ms","start":"2026-05-07T00:53:01.11907Z","end":"2026-05-07T00:53:01.329793Z","steps":["trace[625259867] 'process raft request' (duration: 210.529482ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:53:01.393905Z","caller":"traceutil/trace.go:171","msg":"trace[675825808] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"237.974252ms","start":"2026-05-07T00:53:01.15588Z","end":"2026-05-07T00:53:01.393854Z","steps":["trace[675825808] 'process raft request' (duration: 237.731426ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:53:01.802246Z","caller":"traceutil/trace.go:171","msg":"trace[1794171447] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"120.223221ms","start":"2026-05-07T00:53:01.681879Z","end":"2026-05-07T00:53:01.802102Z","steps":["trace[1794171447] 'process raft request' (duration: 111.914459ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:53:11.121072Z","caller":"traceutil/trace.go:171","msg":"trace[14561105] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"126.379291ms","start":"2026-05-07T00:53:10.994652Z","end":"2026-05-07T00:53:11.121031Z","steps":["trace[14561105] 'process raft request' (duration: 126.045913ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:53:18.088942Z","caller":"traceutil/trace.go:171","msg":"trace[271960583] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"134.682583ms","start":"2026-05-07T00:53:17.954232Z","end":"2026-05-07T00:53:18.088915Z","steps":["trace[271960583] 'process raft request' (duration: 60.655009ms)","trace[271960583] 'compare' (duration: 73.901111ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:53:18.103715Z","caller":"traceutil/trace.go:171","msg":"trace[1685957879] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"148.998113ms","start":"2026-05-07T00:53:17.954695Z","end":"2026-05-07T00:53:18.103693Z","steps":["trace[1685957879] 'process raft request' (duration: 148.86727ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:53:18.103997Z","caller":"traceutil/trace.go:171","msg":"trace[981833818] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"147.404384ms","start":"2026-05-07T00:53:17.956572Z","end":"2026-05-07T00:53:18.103976Z","steps":["trace[981833818] 'process raft request' (duration: 147.094616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:53:18.104162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.513087ms","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-05-07T00:53:18.104228Z","caller":"traceutil/trace.go:171","msg":"trace[975004693] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1893; }","duration":"136.616331ms","start":"2026-05-07T00:53:17.967602Z","end":"2026-05-07T00:53:18.104218Z","steps":["trace[975004693] 'agreement among raft nodes before linearized reading' (duration: 136.436876ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:53:18.104267Z","caller":"traceutil/trace.go:171","msg":"trace[912353119] linearizableReadLoop","detail":"{readStateIndex:1971; appliedIndex:1968; }","duration":"136.234701ms","start":"2026-05-07T00:53:17.96762Z","end":"2026-05-07T00:53:18.103855Z","steps":["trace[912353119] 'read index received' (duration: 47.247531ms)","trace[912353119] 'applied index is now lower than readState.Index' (duration: 88.98581ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:53:21.239808Z","caller":"traceutil/trace.go:171","msg":"trace[1818634389] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"101.274079ms","start":"2026-05-07T00:53:21.138503Z","end":"2026-05-07T00:53:21.239777Z","steps":["trace[1818634389] 'process raft request' (duration: 101.088694ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:54:10.320491Z","caller":"traceutil/trace.go:171","msg":"trace[1205791745] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"194.851487ms","start":"2026-05-07T00:54:10.125605Z","end":"2026-05-07T00:54:10.320457Z","steps":["trace[1205791745] 'process raft request' (duration: 152.336757ms)","trace[1205791745] 'compare' (duration: 42.388397ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:54:10.32062Z","caller":"traceutil/trace.go:171","msg":"trace[1649414579] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2217; }","duration":"194.689224ms","start":"2026-05-07T00:54:10.125903Z","end":"2026-05-07T00:54:10.320592Z","steps":["trace[1649414579] 'read index received' (duration: 151.954108ms)","trace[1649414579] 'applied index is now lower than readState.Index' (duration: 42.731686ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:54:10.32081Z","caller":"traceutil/trace.go:171","msg":"trace[1294771811] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"193.043204ms","start":"2026-05-07T00:54:10.127741Z","end":"2026-05-07T00:54:10.320784Z","steps":["trace[1294771811] 'process raft request' (duration: 192.761318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:54:10.32088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.95873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T00:54:10.32095Z","caller":"traceutil/trace.go:171","msg":"trace[1309373009] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2131; }","duration":"195.088453ms","start":"2026-05-07T00:54:10.125849Z","end":"2026-05-07T00:54:10.320937Z","steps":["trace[1309373009] 'agreement among raft nodes before linearized reading' (duration: 194.833207ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:54:10.607668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.56998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T00:54:10.607819Z","caller":"traceutil/trace.go:171","msg":"trace[10655030] linearizableReadLoop","detail":"{readStateIndex:2220; appliedIndex:2219; }","duration":"224.53656ms","start":"2026-05-07T00:54:10.383261Z","end":"2026-05-07T00:54:10.607798Z","steps":["trace[10655030] 'read index received' (duration: 74.702403ms)","trace[10655030] 'applied index is now lower than readState.Index' (duration: 149.832807ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:54:10.607847Z","caller":"traceutil/trace.go:171","msg":"trace[838542434] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"253.380182ms","start":"2026-05-07T00:54:10.35444Z","end":"2026-05-07T00:54:10.60782Z","steps":["trace[838542434] 'process raft request' (duration: 103.522665ms)","trace[838542434] 'compare' (duration: 149.386206ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:54:10.60816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.395157ms","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":"warn","ts":"2026-05-07T00:54:10.60824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.99346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-07T00:54:10.608262Z","caller":"traceutil/trace.go:171","msg":"trace[1785703092] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2132; }","duration":"219.511339ms","start":"2026-05-07T00:54:10.388729Z","end":"2026-05-07T00:54:10.60824Z","steps":["trace[1785703092] 'agreement among raft nodes before linearized reading' (duration: 219.269493ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:54:10.608286Z","caller":"traceutil/trace.go:171","msg":"trace[1158850434] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2132; }","duration":"225.098793ms","start":"2026-05-07T00:54:10.38317Z","end":"2026-05-07T00:54:10.608269Z","steps":["trace[1158850434] 'agreement among raft nodes before linearized reading' (duration: 224.735544ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:54:10.939153Z","caller":"traceutil/trace.go:171","msg":"trace[943379567] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"326.17527ms","start":"2026-05-07T00:54:10.612945Z","end":"2026-05-07T00:54:10.93912Z","steps":["trace[943379567] 'process raft request' (duration: 270.492543ms)","trace[943379567] 'compare' (duration: 55.567434ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:54:10.93931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:54:10.612916Z","time spent":"326.314502ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:54:10.984932Z","caller":"traceutil/trace.go:171","msg":"trace[983254478] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"371.826566ms","start":"2026-05-07T00:54:10.613075Z","end":"2026-05-07T00:54:10.984902Z","steps":["trace[983254478] 'process raft request' (duration: 371.668332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T00:54:10.985272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T00:54:10.613046Z","time spent":"371.954228ms","remote":"127.0.0.1:55596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T00:54:32.447854Z","caller":"traceutil/trace.go:171","msg":"trace[1132390987] transaction","detail":"{read_only:false; response_revision:2259; number_of_response:1; }","duration":"296.432957ms","start":"2026-05-07T00:54:32.151398Z","end":"2026-05-07T00:54:32.447831Z","steps":["trace[1132390987] 'process raft request' (duration: 296.303464ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T00:54:45.334767Z","caller":"traceutil/trace.go:171","msg":"trace[126819020] transaction","detail":"{read_only:false; response_revision:2329; number_of_response:1; }","duration":"117.770367ms","start":"2026-05-07T00:54:45.216964Z","end":"2026-05-07T00:54:45.334735Z","steps":["trace[126819020] 'process raft request' (duration: 106.024325ms)","trace[126819020] 'compare' (duration: 11.323842ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:54:48.406382Z","caller":"traceutil/trace.go:171","msg":"trace[1564583633] linearizableReadLoop","detail":"{readStateIndex:2439; appliedIndex:2438; }","duration":"112.309456ms","start":"2026-05-07T00:54:48.294036Z","end":"2026-05-07T00:54:48.406345Z","steps":["trace[1564583633] 'read index received' (duration: 101.562028ms)","trace[1564583633] 'applied index is now lower than readState.Index' (duration: 10.745798ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T00:54:48.406408Z","caller":"traceutil/trace.go:171","msg":"trace[1392631658] transaction","detail":"{read_only:false; response_revision:2341; number_of_response:1; }","duration":"161.303482ms","start":"2026-05-07T00:54:48.245068Z","end":"2026-05-07T00:54:48.406372Z","steps":["trace[1392631658] 'process raft request' (duration: 150.476663ms)","trace[1392631658] 'compare' (duration: 10.492991ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T00:54:48.406543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.48744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node-proxier\" ","response":"range_response_count:1 size:699"} {"level":"info","ts":"2026-05-07T00:54:48.406615Z","caller":"traceutil/trace.go:171","msg":"trace[517215889] range","detail":"{range_begin:/registry/clusterrolebindings/system:node-proxier; range_end:; response_count:1; response_revision:2341; }","duration":"112.617603ms","start":"2026-05-07T00:54:48.293977Z","end":"2026-05-07T00:54:48.406595Z","steps":["trace[517215889] 'agreement among raft nodes before linearized reading' (duration: 112.479339ms)"],"step_count":1}