{"level":"warn","ts":"2026-07-15T04:56:38.023443Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T04:56:38.023569Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-07-15T04:56:38.023675Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T04:56:38.023693Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-07-15T04:56:38.023716Z","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-07-15T04:56:38.024639Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-07-15T04:56:38.02479Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-07-15T04:56:38.028656Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.395524ms"} {"level":"info","ts":"2026-07-15T04:56:38.038916Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-07-15T04:56:38.038985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-07-15T04:56:38.039015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-07-15T04:56:38.039022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-15T04:56:38.039029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-07-15T04:56:38.039063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-07-15T04:56:38.051679Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-15T04:56:38.052851Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-15T04:56:38.053809Z","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-07-15T04:56:38.055777Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-15T04:56:38.057197Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-15T04:56:38.06148Z","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-07-15T04:56:38.061544Z","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-07-15T04:56:38.061565Z","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-07-15T04:56:38.062229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-07-15T04:56:38.062432Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-07-15T04:56:38.066237Z","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-07-15T04:56:38.066395Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-07-15T04:56:38.066482Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-07-15T04:56:38.066599Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-15T04:56:38.066669Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-15T04:56:38.439579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-07-15T04:56:38.439714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-15T04:56:38.439807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-07-15T04:56:38.439839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-07-15T04:56:38.439885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-07-15T04:56:38.43991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-07-15T04:56:38.43993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-07-15T04:56:38.441561Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-07-15T04:56:38.441577Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T04:56:38.441852Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T04:56:38.442201Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:56:38.442534Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-15T04:56:38.442589Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-15T04:56:38.443105Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:56:38.443209Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:56:38.443293Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:56:38.446158Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-07-15T04:56:38.446455Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-15T04:57:12.926379Z","caller":"traceutil/trace.go:171","msg":"trace[319264749] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"178.289556ms","start":"2026-07-15T04:57:12.74424Z","end":"2026-07-15T04:57:12.922529Z","steps":["trace[319264749] 'process raft request' (duration: 177.439576ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:14.495777Z","caller":"traceutil/trace.go:171","msg":"trace[1641083936] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"493.350509ms","start":"2026-07-15T04:57:14.0024Z","end":"2026-07-15T04:57:14.495751Z","steps":["trace[1641083936] 'read index received' (duration: 493.157414ms)","trace[1641083936] 'applied index is now lower than readState.Index' (duration: 191.875µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:57:14.495901Z","caller":"traceutil/trace.go:171","msg":"trace[1634664989] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"494.131089ms","start":"2026-07-15T04:57:14.001758Z","end":"2026-07-15T04:57:14.495889Z","steps":["trace[1634664989] 'process raft request' (duration: 493.819982ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:14.496057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.639786ms","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-07-15T04:57:14.496161Z","caller":"traceutil/trace.go:171","msg":"trace[825799800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:522; }","duration":"493.772949ms","start":"2026-07-15T04:57:14.002369Z","end":"2026-07-15T04:57:14.496142Z","steps":["trace[825799800] 'agreement among raft nodes before linearized reading' (duration: 493.614965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:14.4962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:14.002356Z","time spent":"493.835801ms","remote":"127.0.0.1:39588","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-07-15T04:57:14.496426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:14.001738Z","time spent":"494.19178ms","remote":"127.0.0.1:39588","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-07-15T04:57:14.49805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.769582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:57:14.498103Z","caller":"traceutil/trace.go:171","msg":"trace[1654425990] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:523; }","duration":"393.856875ms","start":"2026-07-15T04:57:14.104233Z","end":"2026-07-15T04:57:14.49809Z","steps":["trace[1654425990] 'agreement among raft nodes before linearized reading' (duration: 393.766372ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:14.498133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:14.104216Z","time spent":"393.909397ms","remote":"127.0.0.1:39432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-07-15T04:57:14.498358Z","caller":"traceutil/trace.go:171","msg":"trace[1341849548] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"474.208225ms","start":"2026-07-15T04:57:14.02414Z","end":"2026-07-15T04:57:14.498348Z","steps":["trace[1341849548] 'process raft request' (duration: 473.770703ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:14.498436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:14.02413Z","time spent":"474.257756ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:57:14.49859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.217849ms","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-07-15T04:57:14.498622Z","caller":"traceutil/trace.go:171","msg":"trace[1503086752] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:523; }","duration":"242.278291ms","start":"2026-07-15T04:57:14.256335Z","end":"2026-07-15T04:57:14.498613Z","steps":["trace[1503086752] 'agreement among raft nodes before linearized reading' (duration: 242.225869ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:20.133237Z","caller":"traceutil/trace.go:171","msg":"trace[667469508] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"144.979221ms","start":"2026-07-15T04:57:19.988233Z","end":"2026-07-15T04:57:20.133212Z","steps":["trace[667469508] 'process raft request' (duration: 144.421938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:21.497632Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727626481802343,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-15T04:57:21.83447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.874071ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:57:21.834563Z","caller":"traceutil/trace.go:171","msg":"trace[288387140] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"875.543464ms","start":"2026-07-15T04:57:20.959003Z","end":"2026-07-15T04:57:21.834547Z","steps":["trace[288387140] 'process raft request' (duration: 723.373186ms)","trace[288387140] 'compare' (duration: 151.572704ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:57:21.834794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:20.95898Z","time spent":"875.722029ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:57:21.911484Z","caller":"traceutil/trace.go:171","msg":"trace[2077833946] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:648; }","duration":"914.594313ms","start":"2026-07-15T04:57:20.996821Z","end":"2026-07-15T04:57:21.911415Z","steps":["trace[2077833946] 'read index received' (duration: 685.604861ms)","trace[2077833946] 'applied index is now lower than readState.Index' (duration: 228.988012ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:57:21.911553Z","caller":"traceutil/trace.go:171","msg":"trace[391580423] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"644.709018ms","start":"2026-07-15T04:57:21.266822Z","end":"2026-07-15T04:57:21.911531Z","steps":["trace[391580423] 'process raft request' (duration: 643.891358ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:21.911668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:21.266802Z","time spent":"644.801761ms","remote":"127.0.0.1:39432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:57:21.912473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.978807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-15T04:57:21.91287Z","caller":"traceutil/trace.go:171","msg":"trace[1425580647] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:631; }","duration":"482.729016ms","start":"2026-07-15T04:57:21.429941Z","end":"2026-07-15T04:57:21.91267Z","steps":["trace[1425580647] 'agreement among raft nodes before linearized reading' (duration: 481.969647ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:21.913276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.158701ms","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-07-15T04:57:21.915235Z","caller":"traceutil/trace.go:171","msg":"trace[363285046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"918.384917ms","start":"2026-07-15T04:57:20.996793Z","end":"2026-07-15T04:57:21.915178Z","steps":["trace[363285046] 'agreement among raft nodes before linearized reading' (duration: 914.87262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:21.91538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:20.99678Z","time spent":"918.572241ms","remote":"127.0.0.1:39588","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-07-15T04:57:21.914726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.151202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-q9s95\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-15T04:57:21.915665Z","caller":"traceutil/trace.go:171","msg":"trace[184177185] range","detail":"{range_begin:/registry/pods/kube-system/cilium-q9s95; range_end:; response_count:1; response_revision:631; }","duration":"374.093735ms","start":"2026-07-15T04:57:21.541546Z","end":"2026-07-15T04:57:21.915639Z","steps":["trace[184177185] 'agreement among raft nodes before linearized reading' (duration: 372.056835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:21.915713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:21.541517Z","time spent":"374.180307ms","remote":"127.0.0.1:39508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-q9s95\" "} {"level":"warn","ts":"2026-07-15T04:57:21.914956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.456718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:57:21.915965Z","caller":"traceutil/trace.go:171","msg":"trace[493555106] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"315.501383ms","start":"2026-07-15T04:57:21.600448Z","end":"2026-07-15T04:57:21.915949Z","steps":["trace[493555106] 'agreement among raft nodes before linearized reading' (duration: 311.648119ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:21.916029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:21.600436Z","time spent":"315.578296ms","remote":"127.0.0.1:39322","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-07-15T04:57:21.913378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:21.429919Z","time spent":"483.146656ms","remote":"127.0.0.1:39352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.138\" "} {"level":"warn","ts":"2026-07-15T04:57:22.906943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.561825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:57:22.907309Z","caller":"traceutil/trace.go:171","msg":"trace[1199537941] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"334.034412ms","start":"2026-07-15T04:57:22.573257Z","end":"2026-07-15T04:57:22.907292Z","steps":["trace[1199537941] 'read index received' (duration: 38.501µs)","trace[1199537941] 'applied index is now lower than readState.Index' (duration: 333.995001ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:57:22.907327Z","caller":"traceutil/trace.go:171","msg":"trace[2094771035] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"941.20118ms","start":"2026-07-15T04:57:21.966095Z","end":"2026-07-15T04:57:22.907296Z","steps":["trace[2094771035] 'process raft request' (duration: 130.222625ms)","trace[2094771035] 'compare' (duration: 810.062613ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:57:22.907415Z","caller":"traceutil/trace.go:171","msg":"trace[134993350] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"921.607605ms","start":"2026-07-15T04:57:21.985769Z","end":"2026-07-15T04:57:22.907377Z","steps":["trace[134993350] 'process raft request' (duration: 921.265697ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:22.907456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:21.966075Z","time spent":"941.336204ms","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-15T04:57:22.907533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.272689ms","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-07-15T04:57:22.907565Z","caller":"traceutil/trace.go:171","msg":"trace[2137055254] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"334.349851ms","start":"2026-07-15T04:57:22.573205Z","end":"2026-07-15T04:57:22.907554Z","steps":["trace[2137055254] 'agreement among raft nodes before linearized reading' (duration: 334.179707ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:22.907593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:22.573166Z","time spent":"334.420663ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-15T04:57:22.907596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:21.985737Z","time spent":"921.755519ms","remote":"127.0.0.1:39352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:57:22.907754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.863628ms","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-07-15T04:57:22.907803Z","caller":"traceutil/trace.go:171","msg":"trace[1134892924] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"314.946819ms","start":"2026-07-15T04:57:22.592842Z","end":"2026-07-15T04:57:22.907788Z","steps":["trace[1134892924] 'agreement among raft nodes before linearized reading' (duration: 314.817926ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:22.907839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:22.59283Z","time spent":"315.002052ms","remote":"127.0.0.1:39588","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-07-15T04:57:22.907881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.292531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T04:57:22.90788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.869302ms","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-07-15T04:57:22.907913Z","caller":"traceutil/trace.go:171","msg":"trace[661488898] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"307.350692ms","start":"2026-07-15T04:57:22.600552Z","end":"2026-07-15T04:57:22.907903Z","steps":["trace[661488898] 'agreement among raft nodes before linearized reading' (duration: 307.303831ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:22.90794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:22.600533Z","time spent":"307.400844ms","remote":"127.0.0.1:39322","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-07-15T04:57:22.907944Z","caller":"traceutil/trace.go:171","msg":"trace[1767937231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"300.969225ms","start":"2026-07-15T04:57:22.606957Z","end":"2026-07-15T04:57:22.907926Z","steps":["trace[1767937231] 'agreement among raft nodes before linearized reading' (duration: 300.767139ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:22.907977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:22.606944Z","time spent":"301.027416ms","remote":"127.0.0.1:39588","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-07-15T04:57:24.101665Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727626481802364,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-15T04:57:24.16774Z","caller":"traceutil/trace.go:171","msg":"trace[184855002] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"566.451069ms","start":"2026-07-15T04:57:23.601268Z","end":"2026-07-15T04:57:24.167719Z","steps":["trace[184855002] 'read index received' (duration: 565.721771ms)","trace[184855002] 'applied index is now lower than readState.Index' (duration: 728.358µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:57:24.167873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.592653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:57:24.16799Z","caller":"traceutil/trace.go:171","msg":"trace[998282318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"566.757597ms","start":"2026-07-15T04:57:23.601221Z","end":"2026-07-15T04:57:24.167978Z","steps":["trace[998282318] 'agreement among raft nodes before linearized reading' (duration: 566.609133ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:24.168059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.467322ms","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-07-15T04:57:24.167896Z","caller":"traceutil/trace.go:171","msg":"trace[1387152809] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"877.059803ms","start":"2026-07-15T04:57:23.290798Z","end":"2026-07-15T04:57:24.167858Z","steps":["trace[1387152809] 'process raft request' (duration: 876.445858ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:24.168131Z","caller":"traceutil/trace.go:171","msg":"trace[101698755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"170.588095ms","start":"2026-07-15T04:57:23.997527Z","end":"2026-07-15T04:57:24.168115Z","steps":["trace[101698755] 'agreement among raft nodes before linearized reading' (duration: 170.369ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:24.168244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:23.601201Z","time spent":"567.028614ms","remote":"127.0.0.1:39322","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-07-15T04:57:24.168317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:23.290741Z","time spent":"877.441802ms","remote":"127.0.0.1:39432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:57:25.904921Z","caller":"traceutil/trace.go:171","msg":"trace[63159956] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"211.955769ms","start":"2026-07-15T04:57:25.692937Z","end":"2026-07-15T04:57:25.904893Z","steps":["trace[63159956] 'process raft request' (duration: 211.784125ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:35.268838Z","caller":"traceutil/trace.go:171","msg":"trace[1109915938] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"136.002399ms","start":"2026-07-15T04:57:35.132811Z","end":"2026-07-15T04:57:35.268814Z","steps":["trace[1109915938] 'process raft request' (duration: 133.20323ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:35.295963Z","caller":"traceutil/trace.go:171","msg":"trace[2103356551] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"156.716191ms","start":"2026-07-15T04:57:35.139187Z","end":"2026-07-15T04:57:35.295903Z","steps":["trace[2103356551] 'process raft request' (duration: 156.535667ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:38.352496Z","caller":"traceutil/trace.go:171","msg":"trace[165959328] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"104.619705ms","start":"2026-07-15T04:57:38.247857Z","end":"2026-07-15T04:57:38.352477Z","steps":["trace[165959328] 'process raft request' (duration: 104.512772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:41.248708Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727626481802690,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-15T04:57:41.58018Z","caller":"traceutil/trace.go:171","msg":"trace[58305020] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:829; }","duration":"831.552022ms","start":"2026-07-15T04:57:40.748605Z","end":"2026-07-15T04:57:41.580157Z","steps":["trace[58305020] 'read index received' (duration: 831.343497ms)","trace[58305020] 'applied index is now lower than readState.Index' (duration: 207.495µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:57:41.580345Z","caller":"traceutil/trace.go:171","msg":"trace[1635501821] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"923.31986ms","start":"2026-07-15T04:57:40.656966Z","end":"2026-07-15T04:57:41.580286Z","steps":["trace[1635501821] 'process raft request' (duration: 923.050163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:41.580487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:40.656938Z","time spent":"923.444613ms","remote":"127.0.0.1:39508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:57:41.580935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.068782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-15T04:57:41.580925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.29625ms","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-07-15T04:57:41.580978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.781173ms","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-07-15T04:57:41.58101Z","caller":"traceutil/trace.go:171","msg":"trace[168520069] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:803; }","duration":"149.173615ms","start":"2026-07-15T04:57:41.431818Z","end":"2026-07-15T04:57:41.580991Z","steps":["trace[168520069] 'agreement among raft nodes before linearized reading' (duration: 149.052852ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:41.581018Z","caller":"traceutil/trace.go:171","msg":"trace[311316020] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:803; }","duration":"832.407733ms","start":"2026-07-15T04:57:40.748593Z","end":"2026-07-15T04:57:41.581Z","steps":["trace[311316020] 'agreement among raft nodes before linearized reading' (duration: 832.260179ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:41.581027Z","caller":"traceutil/trace.go:171","msg":"trace[864771916] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:803; }","duration":"528.853435ms","start":"2026-07-15T04:57:41.05216Z","end":"2026-07-15T04:57:41.581014Z","steps":["trace[864771916] 'agreement among raft nodes before linearized reading' (duration: 528.6524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:41.581071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:40.748544Z","time spent":"832.515847ms","remote":"127.0.0.1:39420","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-07-15T04:57:41.581068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:41.052152Z","time spent":"528.908647ms","remote":"127.0.0.1:39588","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-07-15T04:57:41.581319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.049726ms","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-07-15T04:57:41.581364Z","caller":"traceutil/trace.go:171","msg":"trace[276766853] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:803; }","duration":"154.136369ms","start":"2026-07-15T04:57:41.427216Z","end":"2026-07-15T04:57:41.581352Z","steps":["trace[276766853] 'agreement among raft nodes before linearized reading' (duration: 153.299908ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:41.581376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.285417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-15T04:57:41.580804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.228018ms","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-07-15T04:57:41.581505Z","caller":"traceutil/trace.go:171","msg":"trace[367795590] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:803; }","duration":"538.507073ms","start":"2026-07-15T04:57:41.042969Z","end":"2026-07-15T04:57:41.581476Z","steps":["trace[367795590] 'agreement among raft nodes before linearized reading' (duration: 537.442057ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:41.581565Z","caller":"traceutil/trace.go:171","msg":"trace[1990390972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:803; }","duration":"529.024678ms","start":"2026-07-15T04:57:41.052513Z","end":"2026-07-15T04:57:41.581538Z","steps":["trace[1990390972] 'agreement among raft nodes before linearized reading' (duration: 528.141587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:57:41.581575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:41.042947Z","time spent":"538.614286ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-15T04:57:41.581611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:57:41.052506Z","time spent":"529.09141ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-15T04:58:15.847475Z","caller":"traceutil/trace.go:171","msg":"trace[1073932772] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"163.736914ms","start":"2026-07-15T04:58:15.683714Z","end":"2026-07-15T04:58:15.847451Z","steps":["trace[1073932772] 'process raft request' (duration: 163.578341ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:16.374991Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727626481803164,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-15T04:58:16.461379Z","caller":"traceutil/trace.go:171","msg":"trace[682995802] linearizableReadLoop","detail":"{readStateIndex:1056; appliedIndex:1055; }","duration":"586.618781ms","start":"2026-07-15T04:58:15.874736Z","end":"2026-07-15T04:58:16.461355Z","steps":["trace[682995802] 'read index received' (duration: 586.383505ms)","trace[682995802] 'applied index is now lower than readState.Index' (duration: 234.186µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:58:16.461697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.947509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-15T04:58:16.46176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.38925ms","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-07-15T04:58:16.461774Z","caller":"traceutil/trace.go:171","msg":"trace[1990355773] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1021; }","duration":"587.071753ms","start":"2026-07-15T04:58:15.874683Z","end":"2026-07-15T04:58:16.461755Z","steps":["trace[1990355773] 'agreement among raft nodes before linearized reading' (duration: 586.862187ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:16.461811Z","caller":"traceutil/trace.go:171","msg":"trace[817993077] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1021; }","duration":"568.483754ms","start":"2026-07-15T04:58:15.893316Z","end":"2026-07-15T04:58:16.461799Z","steps":["trace[817993077] 'agreement among raft nodes before linearized reading' (duration: 568.329429ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:16.461821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:15.874663Z","time spent":"587.150135ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-15T04:58:16.461847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:15.893293Z","time spent":"568.545515ms","remote":"127.0.0.1:39588","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-07-15T04:58:16.461826Z","caller":"traceutil/trace.go:171","msg":"trace[1756299710] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"611.513197ms","start":"2026-07-15T04:58:15.850262Z","end":"2026-07-15T04:58:16.461776Z","steps":["trace[1756299710] 'process raft request' (duration: 610.934232ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:16.461929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.360577ms","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-07-15T04:58:16.461991Z","caller":"traceutil/trace.go:171","msg":"trace[551380694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1021; }","duration":"567.459589ms","start":"2026-07-15T04:58:15.894518Z","end":"2026-07-15T04:58:16.461977Z","steps":["trace[551380694] 'agreement among raft nodes before linearized reading' (duration: 567.284595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:16.46203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:15.894499Z","time spent":"567.52463ms","remote":"127.0.0.1:39588","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-07-15T04:58:16.461977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:15.850246Z","time spent":"611.65292ms","remote":"127.0.0.1:39588","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-07-15T04:58:16.779303Z","caller":"traceutil/trace.go:171","msg":"trace[1862497257] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"313.610629ms","start":"2026-07-15T04:58:16.465666Z","end":"2026-07-15T04:58:16.779276Z","steps":["trace[1862497257] 'process raft request' (duration: 313.21906ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:16.779803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:16.465646Z","time spent":"313.920337ms","remote":"127.0.0.1:39588","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-07-15T04:58:16.77979Z","caller":"traceutil/trace.go:171","msg":"trace[435803887] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"313.989688ms","start":"2026-07-15T04:58:16.46577Z","end":"2026-07-15T04:58:16.77976Z","steps":["trace[435803887] 'process raft request' (duration: 313.193159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:16.779959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:16.465752Z","time spent":"314.115562ms","remote":"127.0.0.1:39588","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-07-15T04:58:16.780272Z","caller":"traceutil/trace.go:171","msg":"trace[383910984] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"314.674805ms","start":"2026-07-15T04:58:16.465584Z","end":"2026-07-15T04:58:16.780259Z","steps":["trace[383910984] 'process raft request' (duration: 246.382088ms)","trace[383910984] 'compare' (duration: 66.504314ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:58:16.780339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:16.465557Z","time spent":"314.748207ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:58:17.083795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.785549ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-15T04:58:17.083891Z","caller":"traceutil/trace.go:171","msg":"trace[820343021] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1056; }","duration":"557.889674ms","start":"2026-07-15T04:58:16.525984Z","end":"2026-07-15T04:58:17.083874Z","steps":["trace[820343021] 'read index received' (duration: 186.001476ms)","trace[820343021] 'applied index is now lower than readState.Index' (duration: 371.886737ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:58:17.084105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.497841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:58:17.084126Z","caller":"traceutil/trace.go:171","msg":"trace[113929737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1024; }","duration":"482.551361ms","start":"2026-07-15T04:58:16.601567Z","end":"2026-07-15T04:58:17.084118Z","steps":["trace[113929737] 'agreement among raft nodes before linearized reading' (duration: 482.49829ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:17.084148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:16.601554Z","time spent":"482.589093ms","remote":"127.0.0.1:39322","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-07-15T04:58:17.084138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.13517ms","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-07-15T04:58:17.084214Z","caller":"traceutil/trace.go:171","msg":"trace[1223917433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1024; }","duration":"558.242002ms","start":"2026-07-15T04:58:16.525951Z","end":"2026-07-15T04:58:17.084193Z","steps":["trace[1223917433] 'agreement among raft nodes before linearized reading' (duration: 558.038777ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:17.08429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:16.525938Z","time spent":"558.340215ms","remote":"127.0.0.1:39588","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-07-15T04:58:38.341748Z","caller":"traceutil/trace.go:171","msg":"trace[534501590] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"379.235289ms","start":"2026-07-15T04:58:37.962481Z","end":"2026-07-15T04:58:38.341716Z","steps":["trace[534501590] 'process raft request' (duration: 379.095015ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:38.341923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:37.962454Z","time spent":"379.380062ms","remote":"127.0.0.1:39588","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-07-15T04:58:40.604463Z","caller":"traceutil/trace.go:171","msg":"trace[1222491339] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"256.06156ms","start":"2026-07-15T04:58:40.348365Z","end":"2026-07-15T04:58:40.604427Z","steps":["trace[1222491339] 'process raft request' (duration: 255.853725ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:40.815568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.81349ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:58:40.815687Z","caller":"traceutil/trace.go:171","msg":"trace[1642214112] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"205.063761ms","start":"2026-07-15T04:58:40.61059Z","end":"2026-07-15T04:58:40.815653Z","steps":["trace[1642214112] 'process raft request' (duration: 95.083317ms)","trace[1642214112] 'compare' (duration: 109.604515ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:58:41.021884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.504841ms","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-07-15T04:58:41.021992Z","caller":"traceutil/trace.go:171","msg":"trace[1357456079] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1099; }","duration":"100.690965ms","start":"2026-07-15T04:58:40.921278Z","end":"2026-07-15T04:58:41.021969Z","steps":["trace[1357456079] 'range keys from in-memory index tree' (duration: 100.250414ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:43.376004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.835965ms","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-07-15T04:58:43.37604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.494902ms","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-07-15T04:58:43.376102Z","caller":"traceutil/trace.go:171","msg":"trace[1822254859] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1105; }","duration":"332.983759ms","start":"2026-07-15T04:58:43.043096Z","end":"2026-07-15T04:58:43.37608Z","steps":["trace[1822254859] 'range keys from in-memory index tree' (duration: 332.695252ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:43.376132Z","caller":"traceutil/trace.go:171","msg":"trace[71757674] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1105; }","duration":"301.633376ms","start":"2026-07-15T04:58:43.07448Z","end":"2026-07-15T04:58:43.376114Z","steps":["trace[71757674] 'range keys from in-memory index tree' (duration: 301.312667ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:43.37616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:43.043078Z","time spent":"333.068011ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-15T04:58:43.376182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:43.074469Z","time spent":"301.703237ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-15T04:58:43.376379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.184653ms","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-07-15T04:58:43.376409Z","caller":"traceutil/trace.go:171","msg":"trace[1214323525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1105; }","duration":"303.254504ms","start":"2026-07-15T04:58:43.073143Z","end":"2026-07-15T04:58:43.376397Z","steps":["trace[1214323525] 'range keys from in-memory index tree' (duration: 303.05542ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:43.376435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:43.073114Z","time spent":"303.314136ms","remote":"127.0.0.1:39588","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-07-15T04:58:43.376438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.076761ms","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-07-15T04:58:43.376515Z","caller":"traceutil/trace.go:171","msg":"trace[2005029089] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1105; }","duration":"557.191604ms","start":"2026-07-15T04:58:42.819302Z","end":"2026-07-15T04:58:43.376493Z","steps":["trace[2005029089] 'range keys from in-memory index tree' (duration: 556.798413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:43.37657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:42.819287Z","time spent":"557.273385ms","remote":"127.0.0.1:39588","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-07-15T04:58:43.376619Z","caller":"traceutil/trace.go:171","msg":"trace[124644098] linearizableReadLoop","detail":"{readStateIndex:1147; appliedIndex:1146; }","duration":"163.119306ms","start":"2026-07-15T04:58:43.213476Z","end":"2026-07-15T04:58:43.376596Z","steps":["trace[124644098] 'read index received' (duration: 77.440362ms)","trace[124644098] 'applied index is now lower than readState.Index' (duration: 85.677934ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:58:43.376721Z","caller":"traceutil/trace.go:171","msg":"trace[1087895681] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"241.154042ms","start":"2026-07-15T04:58:43.135546Z","end":"2026-07-15T04:58:43.3767Z","steps":["trace[1087895681] 'process raft request' (duration: 155.429727ms)","trace[1087895681] 'compare' (duration: 85.411267ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:58:43.376808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.322291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-15T04:58:43.376857Z","caller":"traceutil/trace.go:171","msg":"trace[1055902846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1106; }","duration":"163.412983ms","start":"2026-07-15T04:58:43.213428Z","end":"2026-07-15T04:58:43.376841Z","steps":["trace[1055902846] 'agreement among raft nodes before linearized reading' (duration: 163.249419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:43.66323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.67852ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:58:43.663479Z","caller":"traceutil/trace.go:171","msg":"trace[1090951263] linearizableReadLoop","detail":"{readStateIndex:1152; appliedIndex:1147; }","duration":"125.370585ms","start":"2026-07-15T04:58:43.538079Z","end":"2026-07-15T04:58:43.66345Z","steps":["trace[1090951263] 'read index received' (duration: 10.344266ms)","trace[1090951263] 'applied index is now lower than readState.Index' (duration: 115.025419ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:58:43.66347Z","caller":"traceutil/trace.go:171","msg":"trace[920748994] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"282.093563ms","start":"2026-07-15T04:58:43.381346Z","end":"2026-07-15T04:58:43.66344Z","steps":["trace[920748994] 'process raft request' (duration: 167.120805ms)","trace[920748994] 'compare' (duration: 114.476535ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:58:43.663568Z","caller":"traceutil/trace.go:171","msg":"trace[1703974] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"282.066503ms","start":"2026-07-15T04:58:43.381489Z","end":"2026-07-15T04:58:43.663556Z","steps":["trace[1703974] 'process raft request' (duration: 281.901428ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:43.663574Z","caller":"traceutil/trace.go:171","msg":"trace[1517327995] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"282.050282ms","start":"2026-07-15T04:58:43.381489Z","end":"2026-07-15T04:58:43.66354Z","steps":["trace[1517327995] 'process raft request' (duration: 281.873158ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:43.663684Z","caller":"traceutil/trace.go:171","msg":"trace[683099205] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"282.151744ms","start":"2026-07-15T04:58:43.381524Z","end":"2026-07-15T04:58:43.663676Z","steps":["trace[683099205] 'process raft request' (duration: 281.897808ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:43.663726Z","caller":"traceutil/trace.go:171","msg":"trace[1157063219] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"282.332049ms","start":"2026-07-15T04:58:43.381362Z","end":"2026-07-15T04:58:43.663694Z","steps":["trace[1157063219] 'process raft request' (duration: 281.95394ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:43.663932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.831106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:58:43.663985Z","caller":"traceutil/trace.go:171","msg":"trace[1345302316] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1111; }","duration":"125.945729ms","start":"2026-07-15T04:58:43.538026Z","end":"2026-07-15T04:58:43.663971Z","steps":["trace[1345302316] 'agreement among raft nodes before linearized reading' (duration: 125.826306ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:58:56.775474Z","caller":"traceutil/trace.go:171","msg":"trace[839358980] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"110.25212ms","start":"2026-07-15T04:58:56.665205Z","end":"2026-07-15T04:58:56.775457Z","steps":["trace[839358980] 'process raft request' (duration: 109.896931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:58.314753Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727626481803617,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-15T04:58:58.509655Z","caller":"traceutil/trace.go:171","msg":"trace[574241121] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"783.167789ms","start":"2026-07-15T04:58:57.726458Z","end":"2026-07-15T04:58:58.509626Z","steps":["trace[574241121] 'process raft request' (duration: 782.931433ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:58.509827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:57.726438Z","time spent":"783.303023ms","remote":"127.0.0.1:39588","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-07-15T04:58:58.510937Z","caller":"traceutil/trace.go:171","msg":"trace[806810250] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1250; }","duration":"696.966903ms","start":"2026-07-15T04:58:57.813951Z","end":"2026-07-15T04:58:58.510918Z","steps":["trace[806810250] 'read index received' (duration: 695.509706ms)","trace[806810250] 'applied index is now lower than readState.Index' (duration: 1.450577ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:58:58.510985Z","caller":"traceutil/trace.go:171","msg":"trace[2025208026] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"693.500457ms","start":"2026-07-15T04:58:57.817468Z","end":"2026-07-15T04:58:58.510968Z","steps":["trace[2025208026] 'process raft request' (duration: 693.324703ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:58.511146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:57.817444Z","time spent":"693.570269ms","remote":"127.0.0.1:39588","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-07-15T04:58:58.511153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.199002ms","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-07-15T04:58:58.511197Z","caller":"traceutil/trace.go:171","msg":"trace[374442422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1206; }","duration":"781.277723ms","start":"2026-07-15T04:58:57.729909Z","end":"2026-07-15T04:58:58.511187Z","steps":["trace[374442422] 'agreement among raft nodes before linearized reading' (duration: 781.089529ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:58.511226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:57.729892Z","time spent":"781.326585ms","remote":"127.0.0.1:39588","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-07-15T04:58:58.511348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.869713ms","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-07-15T04:58:58.511437Z","caller":"traceutil/trace.go:171","msg":"trace[1569807103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1206; }","duration":"779.005997ms","start":"2026-07-15T04:58:57.73241Z","end":"2026-07-15T04:58:58.511416Z","steps":["trace[1569807103] 'agreement among raft nodes before linearized reading' (duration: 778.788071ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:58:58.511497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:58:57.732391Z","time spent":"779.086789ms","remote":"127.0.0.1:39588","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-07-15T04:59:08.735225Z","caller":"traceutil/trace.go:171","msg":"trace[438123364] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"181.652053ms","start":"2026-07-15T04:59:08.55355Z","end":"2026-07-15T04:59:08.735202Z","steps":["trace[438123364] 'process raft request' (duration: 181.498979ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:08.736504Z","caller":"traceutil/trace.go:171","msg":"trace[1686672350] linearizableReadLoop","detail":"{readStateIndex:1287; appliedIndex:1285; }","duration":"174.293292ms","start":"2026-07-15T04:59:08.562202Z","end":"2026-07-15T04:59:08.736495Z","steps":["trace[1686672350] 'read index received' (duration: 172.815465ms)","trace[1686672350] 'applied index is now lower than readState.Index' (duration: 1.477317ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:59:08.736588Z","caller":"traceutil/trace.go:171","msg":"trace[2098469880] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"182.524045ms","start":"2026-07-15T04:59:08.554054Z","end":"2026-07-15T04:59:08.736578Z","steps":["trace[2098469880] 'process raft request' (duration: 182.386902ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:08.736895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.682561ms","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-07-15T04:59:08.736916Z","caller":"traceutil/trace.go:171","msg":"trace[1048599818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1239; }","duration":"174.736572ms","start":"2026-07-15T04:59:08.562173Z","end":"2026-07-15T04:59:08.73691Z","steps":["trace[1048599818] 'agreement among raft nodes before linearized reading' (duration: 174.64597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:08.737034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.588161ms","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-07-15T04:59:08.737086Z","caller":"traceutil/trace.go:171","msg":"trace[726312453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1239; }","duration":"170.691013ms","start":"2026-07-15T04:59:08.566382Z","end":"2026-07-15T04:59:08.737073Z","steps":["trace[726312453] 'agreement among raft nodes before linearized reading' (duration: 170.56191ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:08.737073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.635397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:59:08.737185Z","caller":"traceutil/trace.go:171","msg":"trace[1031232419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1239; }","duration":"135.798301ms","start":"2026-07-15T04:59:08.601365Z","end":"2026-07-15T04:59:08.737164Z","steps":["trace[1031232419] 'agreement among raft nodes before linearized reading' (duration: 135.622447ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:10.901813Z","caller":"traceutil/trace.go:171","msg":"trace[1069140260] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"158.82104ms","start":"2026-07-15T04:59:10.742958Z","end":"2026-07-15T04:59:10.901779Z","steps":["trace[1069140260] 'process raft request' (duration: 158.596405ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:11.038078Z","caller":"traceutil/trace.go:171","msg":"trace[953269066] linearizableReadLoop","detail":"{readStateIndex:1293; appliedIndex:1291; }","duration":"291.389212ms","start":"2026-07-15T04:59:10.746662Z","end":"2026-07-15T04:59:11.038051Z","steps":["trace[953269066] 'read index received' (duration: 154.869243ms)","trace[953269066] 'applied index is now lower than readState.Index' (duration: 136.518709ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:59:11.03846Z","caller":"traceutil/trace.go:171","msg":"trace[586937819] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"294.326815ms","start":"2026-07-15T04:59:10.744115Z","end":"2026-07-15T04:59:11.038442Z","steps":["trace[586937819] 'process raft request' (duration: 293.201796ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:11.038705Z","caller":"traceutil/trace.go:171","msg":"trace[171656053] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"172.498868ms","start":"2026-07-15T04:59:10.866192Z","end":"2026-07-15T04:59:11.03869Z","steps":["trace[171656053] 'process raft request' (duration: 171.782669ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:11.039255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.51454ms","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-07-15T04:59:11.039324Z","caller":"traceutil/trace.go:171","msg":"trace[168466578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1246; }","duration":"292.620493ms","start":"2026-07-15T04:59:10.746687Z","end":"2026-07-15T04:59:11.039307Z","steps":["trace[168466578] 'agreement among raft nodes before linearized reading' (duration: 292.415598ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:11.041407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.731996ms","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-07-15T04:59:11.041456Z","caller":"traceutil/trace.go:171","msg":"trace[968212871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1246; }","duration":"294.795277ms","start":"2026-07-15T04:59:10.746647Z","end":"2026-07-15T04:59:11.041443Z","steps":["trace[968212871] 'agreement among raft nodes before linearized reading' (duration: 292.210563ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:12.877482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.384859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-07-15T04:59:12.87754Z","caller":"traceutil/trace.go:171","msg":"trace[305676592] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1252; }","duration":"111.486392ms","start":"2026-07-15T04:59:12.766042Z","end":"2026-07-15T04:59:12.877528Z","steps":["trace[305676592] 'range keys from in-memory index tree' (duration: 111.259506ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:17.464825Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727626481803796,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-15T04:59:17.795813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.420878ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:59:17.795963Z","caller":"traceutil/trace.go:171","msg":"trace[474892042] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1283; }","duration":"367.578732ms","start":"2026-07-15T04:59:17.428363Z","end":"2026-07-15T04:59:17.795942Z","steps":["trace[474892042] 'range keys from in-memory index tree' (duration: 367.405728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:17.796326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.091845ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:59:17.796565Z","caller":"traceutil/trace.go:171","msg":"trace[1997277962] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"1.104218844s","start":"2026-07-15T04:59:16.692319Z","end":"2026-07-15T04:59:17.796538Z","steps":["trace[1997277962] 'process raft request' (duration: 199.843002ms)","trace[1997277962] 'compare' (duration: 903.461849ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:59:17.796671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:16.692297Z","time spent":"1.104320107s","remote":"127.0.0.1:39714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":797,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:59:18.310581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.15829ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-15T04:59:18.311724Z","caller":"traceutil/trace.go:171","msg":"trace[2059669701] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"1.257713502s","start":"2026-07-15T04:59:17.053992Z","end":"2026-07-15T04:59:18.311706Z","steps":["trace[2059669701] 'process raft request' (duration: 1.256684847s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:18.311822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:17.053967Z","time spent":"1.257795554s","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:59:18.394306Z","caller":"traceutil/trace.go:171","msg":"trace[1836343982] linearizableReadLoop","detail":"{readStateIndex:1336; appliedIndex:1332; }","duration":"1.429842241s","start":"2026-07-15T04:59:16.964441Z","end":"2026-07-15T04:59:18.394283Z","steps":["trace[1836343982] 'read index received' (duration: 658.258127ms)","trace[1836343982] 'applied index is now lower than readState.Index' (duration: 771.582624ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:59:18.39455Z","caller":"traceutil/trace.go:171","msg":"trace[1322795794] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"1.080421766s","start":"2026-07-15T04:59:17.314114Z","end":"2026-07-15T04:59:18.394536Z","steps":["trace[1322795794] 'process raft request' (duration: 997.583322ms)","trace[1322795794] 'compare' (duration: 82.497806ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:59:18.394648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:17.314096Z","time spent":"1.080490417s","remote":"127.0.0.1:39498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5640,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:59:18.394892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.430457727s","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-07-15T04:59:18.394934Z","caller":"traceutil/trace.go:171","msg":"trace[1290518990] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1286; }","duration":"1.430532459s","start":"2026-07-15T04:59:16.96439Z","end":"2026-07-15T04:59:18.394923Z","steps":["trace[1290518990] 'agreement among raft nodes before linearized reading' (duration: 1.430416156s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:18.394964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:16.964368Z","time spent":"1.430589469s","remote":"127.0.0.1:39588","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-07-15T04:59:18.395148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331849493s","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-07-15T04:59:18.395183Z","caller":"traceutil/trace.go:171","msg":"trace[562378415] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1286; }","duration":"1.331913305s","start":"2026-07-15T04:59:17.063262Z","end":"2026-07-15T04:59:18.395175Z","steps":["trace[562378415] 'agreement among raft nodes before linearized reading' (duration: 1.331832033s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:18.395218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:17.063246Z","time spent":"1.331964546s","remote":"127.0.0.1:39588","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-07-15T04:59:18.395555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.714213ms","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-07-15T04:59:18.395609Z","caller":"traceutil/trace.go:171","msg":"trace[1505159525] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1286; }","duration":"456.797325ms","start":"2026-07-15T04:59:17.9388Z","end":"2026-07-15T04:59:18.395597Z","steps":["trace[1505159525] 'agreement among raft nodes before linearized reading' (duration: 456.671732ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:18.395651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:17.938784Z","time spent":"456.860366ms","remote":"127.0.0.1:39588","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-07-15T04:59:18.395814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.000428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:59:18.39586Z","caller":"traceutil/trace.go:171","msg":"trace[2044268864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1286; }","duration":"794.07985ms","start":"2026-07-15T04:59:17.601769Z","end":"2026-07-15T04:59:18.395849Z","steps":["trace[2044268864] 'agreement among raft nodes before linearized reading' (duration: 794.015509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:18.395887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:17.601748Z","time spent":"794.132591ms","remote":"127.0.0.1:39322","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-07-15T04:59:18.396047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.277348768s","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-07-15T04:59:18.396084Z","caller":"traceutil/trace.go:171","msg":"trace[924553258] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1286; }","duration":"1.277415859s","start":"2026-07-15T04:59:17.118659Z","end":"2026-07-15T04:59:18.396074Z","steps":["trace[924553258] 'agreement among raft nodes before linearized reading' (duration: 1.277355287s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:18.396113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:17.118648Z","time spent":"1.27745796s","remote":"127.0.0.1:38024","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-07-15T04:59:18.396292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.329200657s","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-07-15T04:59:18.396325Z","caller":"traceutil/trace.go:171","msg":"trace[1591723011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1286; }","duration":"1.329246147s","start":"2026-07-15T04:59:17.067071Z","end":"2026-07-15T04:59:18.396317Z","steps":["trace[1591723011] 'agreement among raft nodes before linearized reading' (duration: 1.329161875s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:18.396352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:17.067066Z","time spent":"1.329278658s","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-15T04:59:18.39652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.330305634s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-15T04:59:18.396552Z","caller":"traceutil/trace.go:171","msg":"trace[1066518684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1286; }","duration":"1.330364146s","start":"2026-07-15T04:59:17.06618Z","end":"2026-07-15T04:59:18.396544Z","steps":["trace[1066518684] 'agreement among raft nodes before linearized reading' (duration: 1.330286154s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:18.396577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:17.066163Z","time spent":"1.330408157s","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-15T04:59:18.596479Z","caller":"traceutil/trace.go:171","msg":"trace[465720793] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"194.199083ms","start":"2026-07-15T04:59:18.402258Z","end":"2026-07-15T04:59:18.596457Z","steps":["trace[465720793] 'process raft request' (duration: 185.812967ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:18.596798Z","caller":"traceutil/trace.go:171","msg":"trace[559668185] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"191.350393ms","start":"2026-07-15T04:59:18.405424Z","end":"2026-07-15T04:59:18.596774Z","steps":["trace[559668185] 'process raft request' (duration: 190.994895ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:18.596864Z","caller":"traceutil/trace.go:171","msg":"trace[566987131] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"191.349343ms","start":"2026-07-15T04:59:18.405501Z","end":"2026-07-15T04:59:18.59685Z","steps":["trace[566987131] 'process raft request' (duration: 191.159768ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:18.597001Z","caller":"traceutil/trace.go:171","msg":"trace[699926529] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"191.313942ms","start":"2026-07-15T04:59:18.405679Z","end":"2026-07-15T04:59:18.596993Z","steps":["trace[699926529] 'process raft request' (duration: 191.096467ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:19.709618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.998216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:59:19.709682Z","caller":"traceutil/trace.go:171","msg":"trace[300370413] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1292; }","duration":"548.105868ms","start":"2026-07-15T04:59:19.161566Z","end":"2026-07-15T04:59:19.709672Z","steps":["trace[300370413] 'count revisions from in-memory index tree' (duration: 547.940195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:19.70968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.857772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T04:59:19.709707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:19.161549Z","time spent":"548.15245ms","remote":"127.0.0.1:39582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"info","ts":"2026-07-15T04:59:19.709717Z","caller":"traceutil/trace.go:171","msg":"trace[449222029] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1292; }","duration":"107.928974ms","start":"2026-07-15T04:59:19.601778Z","end":"2026-07-15T04:59:19.709707Z","steps":["trace[449222029] 'range keys from in-memory index tree' (duration: 107.790741ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:19.70972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.095303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:59:19.70979Z","caller":"traceutil/trace.go:171","msg":"trace[68751782] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1292; }","duration":"421.203866ms","start":"2026-07-15T04:59:19.288569Z","end":"2026-07-15T04:59:19.709773Z","steps":["trace[68751782] 'count revisions from in-memory index tree' (duration: 421.028392ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:19.709834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:19.288552Z","time spent":"421.271757ms","remote":"127.0.0.1:48752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-15T04:59:20.457755Z","caller":"traceutil/trace.go:171","msg":"trace[229627405] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"164.728857ms","start":"2026-07-15T04:59:20.293007Z","end":"2026-07-15T04:59:20.457736Z","steps":["trace[229627405] 'process raft request' (duration: 164.615414ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:20.869054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.382832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:59:20.869179Z","caller":"traceutil/trace.go:171","msg":"trace[2012027781] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1342; }","duration":"484.323083ms","start":"2026-07-15T04:59:20.38484Z","end":"2026-07-15T04:59:20.869163Z","steps":["trace[2012027781] 'read index received' (duration: 72.737825ms)","trace[2012027781] 'applied index is now lower than readState.Index' (duration: 411.584218ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:59:20.869375Z","caller":"traceutil/trace.go:171","msg":"trace[513024673] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"553.082831ms","start":"2026-07-15T04:59:20.316279Z","end":"2026-07-15T04:59:20.869362Z","steps":["trace[513024673] 'process raft request' (duration: 293.32206ms)","trace[513024673] 'compare' (duration: 258.815658ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:59:20.869451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:20.316257Z","time spent":"553.156543ms","remote":"127.0.0.1:39588","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-07-15T04:59:20.869638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.794526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:59:20.869675Z","caller":"traceutil/trace.go:171","msg":"trace[1232238944] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1294; }","duration":"484.857166ms","start":"2026-07-15T04:59:20.384808Z","end":"2026-07-15T04:59:20.869665Z","steps":["trace[1232238944] 'agreement among raft nodes before linearized reading' (duration: 484.802705ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:20.869707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:20.384794Z","time spent":"484.907128ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-15T04:59:20.871422Z","caller":"traceutil/trace.go:171","msg":"trace[743596284] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"214.183867ms","start":"2026-07-15T04:59:20.657215Z","end":"2026-07-15T04:59:20.871399Z","steps":["trace[743596284] 'process raft request' (duration: 214.070724ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:20.871547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.280915ms","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-07-15T04:59:20.871623Z","caller":"traceutil/trace.go:171","msg":"trace[1491140756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1295; }","duration":"435.427898ms","start":"2026-07-15T04:59:20.436179Z","end":"2026-07-15T04:59:20.871607Z","steps":["trace[1491140756] 'agreement among raft nodes before linearized reading' (duration: 435.219043ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:20.871668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:20.436157Z","time spent":"435.50175ms","remote":"127.0.0.1:39588","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-07-15T04:59:20.871795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.446356ms","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-07-15T04:59:20.871839Z","caller":"traceutil/trace.go:171","msg":"trace[846153578] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1295; }","duration":"266.533008ms","start":"2026-07-15T04:59:20.605296Z","end":"2026-07-15T04:59:20.871829Z","steps":["trace[846153578] 'agreement among raft nodes before linearized reading' (duration: 266.404755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:20.871945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.61223ms","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-07-15T04:59:20.871963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.367245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T04:59:20.872019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.577574ms","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-07-15T04:59:20.872046Z","caller":"traceutil/trace.go:171","msg":"trace[615837703] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1295; }","duration":"200.507699ms","start":"2026-07-15T04:59:20.67152Z","end":"2026-07-15T04:59:20.872028Z","steps":["trace[615837703] 'agreement among raft nodes before linearized reading' (duration: 200.373276ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:20.871956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.656711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:59:20.872054Z","caller":"traceutil/trace.go:171","msg":"trace[39510566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1295; }","duration":"265.638426ms","start":"2026-07-15T04:59:20.606407Z","end":"2026-07-15T04:59:20.872046Z","steps":["trace[39510566] 'agreement among raft nodes before linearized reading' (duration: 265.548574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:20.872081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.765704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-15T04:59:20.872277Z","caller":"traceutil/trace.go:171","msg":"trace[988740960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1295; }","duration":"266.969609ms","start":"2026-07-15T04:59:20.605294Z","end":"2026-07-15T04:59:20.872264Z","steps":["trace[988740960] 'agreement among raft nodes before linearized reading' (duration: 266.701812ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:20.87221Z","caller":"traceutil/trace.go:171","msg":"trace[2116157964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1295; }","duration":"266.961228ms","start":"2026-07-15T04:59:20.605233Z","end":"2026-07-15T04:59:20.872194Z","steps":["trace[2116157964] 'agreement among raft nodes before linearized reading' (duration: 266.64145ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:20.871981Z","caller":"traceutil/trace.go:171","msg":"trace[585063597] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1295; }","duration":"266.676672ms","start":"2026-07-15T04:59:20.605294Z","end":"2026-07-15T04:59:20.871971Z","steps":["trace[585063597] 'agreement among raft nodes before linearized reading' (duration: 266.560889ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:21.101434Z","caller":"traceutil/trace.go:171","msg":"trace[2039583350] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"150.023384ms","start":"2026-07-15T04:59:20.951385Z","end":"2026-07-15T04:59:21.101408Z","steps":["trace[2039583350] 'process raft request' (duration: 146.719712ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:21.136787Z","caller":"traceutil/trace.go:171","msg":"trace[1225004637] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"183.084259ms","start":"2026-07-15T04:59:20.95368Z","end":"2026-07-15T04:59:21.136764Z","steps":["trace[1225004637] 'process raft request' (duration: 182.948855ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:29.477079Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727626481803938,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-15T04:59:29.977458Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727626481803938,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-15T04:59:30.011649Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.043629248s","expected-duration":"1s"} {"level":"info","ts":"2026-07-15T04:59:30.012008Z","caller":"traceutil/trace.go:171","msg":"trace[705349685] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1413; }","duration":"1.035918788s","start":"2026-07-15T04:59:28.976065Z","end":"2026-07-15T04:59:30.011983Z","steps":["trace[705349685] 'read index received' (duration: 1.035698412s)","trace[705349685] 'applied index is now lower than readState.Index' (duration: 219.206µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:59:30.012125Z","caller":"traceutil/trace.go:171","msg":"trace[1197359902] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"1.044164072s","start":"2026-07-15T04:59:28.967925Z","end":"2026-07-15T04:59:30.012089Z","steps":["trace[1197359902] 'process raft request' (duration: 1.043908654s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:30.012233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036151484s","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-07-15T04:59:30.012294Z","caller":"traceutil/trace.go:171","msg":"trace[472289639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1362; }","duration":"1.036254066s","start":"2026-07-15T04:59:28.976025Z","end":"2026-07-15T04:59:30.012279Z","steps":["trace[472289639] 'agreement among raft nodes before linearized reading' (duration: 1.036070782s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:30.012313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.032652798s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-15T04:59:30.012326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:28.967903Z","time spent":"1.044299515s","remote":"127.0.0.1:39588","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-07-15T04:59:30.012348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:28.97601Z","time spent":"1.036324669s","remote":"127.0.0.1:39588","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-07-15T04:59:30.012353Z","caller":"traceutil/trace.go:171","msg":"trace[1251236181] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1362; }","duration":"1.032693859s","start":"2026-07-15T04:59:28.979644Z","end":"2026-07-15T04:59:30.012338Z","steps":["trace[1251236181] 'agreement among raft nodes before linearized reading' (duration: 1.032620617s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:30.012391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:28.979639Z","time spent":"1.03274481s","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-15T04:59:30.012238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03431268s","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-07-15T04:59:30.012455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.103717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T04:59:30.012455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031211772s","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-07-15T04:59:30.012495Z","caller":"traceutil/trace.go:171","msg":"trace[1937238154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1362; }","duration":"1.034587306s","start":"2026-07-15T04:59:28.977895Z","end":"2026-07-15T04:59:30.012482Z","steps":["trace[1937238154] 'agreement among raft nodes before linearized reading' (duration: 1.034249628s)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:30.012509Z","caller":"traceutil/trace.go:171","msg":"trace[702731030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1362; }","duration":"411.190138ms","start":"2026-07-15T04:59:29.601305Z","end":"2026-07-15T04:59:30.012495Z","steps":["trace[702731030] 'agreement among raft nodes before linearized reading' (duration: 411.071836ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:30.012524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029812338s","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-07-15T04:59:30.012539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:28.977889Z","time spent":"1.034638197s","remote":"127.0.0.1:39588","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-07-15T04:59:30.012558Z","caller":"traceutil/trace.go:171","msg":"trace[1139185146] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1362; }","duration":"1.029866759s","start":"2026-07-15T04:59:28.982682Z","end":"2026-07-15T04:59:30.012549Z","steps":["trace[1139185146] 'agreement among raft nodes before linearized reading' (duration: 1.029788797s)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:59:30.01255Z","caller":"traceutil/trace.go:171","msg":"trace[558830577] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1362; }","duration":"1.031308274s","start":"2026-07-15T04:59:28.981204Z","end":"2026-07-15T04:59:30.012513Z","steps":["trace[558830577] 'agreement among raft nodes before linearized reading' (duration: 1.031044317s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:30.01256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:29.601282Z","time spent":"411.271151ms","remote":"127.0.0.1:39322","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-07-15T04:59:30.012422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.434646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"warn","ts":"2026-07-15T04:59:30.01259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:28.982672Z","time spent":"1.029912571s","remote":"127.0.0.1:39588","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-07-15T04:59:30.012608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:28.981146Z","time spent":"1.031452478s","remote":"127.0.0.1:39588","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-07-15T04:59:30.012625Z","caller":"traceutil/trace.go:171","msg":"trace[539267024] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1362; }","duration":"881.701872ms","start":"2026-07-15T04:59:29.130903Z","end":"2026-07-15T04:59:30.012605Z","steps":["trace[539267024] 'agreement among raft nodes before linearized reading' (duration: 881.305092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:30.012684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:29.130881Z","time spent":"881.791905ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-15T04:59:30.012751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.337632ms","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-07-15T04:59:30.012845Z","caller":"traceutil/trace.go:171","msg":"trace[1260363214] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1362; }","duration":"334.459215ms","start":"2026-07-15T04:59:29.67836Z","end":"2026-07-15T04:59:30.012819Z","steps":["trace[1260363214] 'agreement among raft nodes before linearized reading' (duration: 334.012374ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:59:30.01291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:59:29.678337Z","time spent":"334.562238ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-07-15T04:59:30.744047Z","caller":"traceutil/trace.go:171","msg":"trace[1543258403] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"156.440081ms","start":"2026-07-15T04:59:30.587577Z","end":"2026-07-15T04:59:30.744017Z","steps":["trace[1543258403] 'process raft request' (duration: 156.266327ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:00:46.173897Z","caller":"traceutil/trace.go:171","msg":"trace[1515923082] transaction","detail":"{read_only:false; response_revision:1713; number_of_response:1; }","duration":"186.052182ms","start":"2026-07-15T05:00:45.987819Z","end":"2026-07-15T05:00:46.173872Z","steps":["trace[1515923082] 'process raft request' (duration: 185.914809ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:01:29.113843Z","caller":"traceutil/trace.go:171","msg":"trace[463573512] linearizableReadLoop","detail":"{readStateIndex:1989; appliedIndex:1988; }","duration":"185.99784ms","start":"2026-07-15T05:01:28.927816Z","end":"2026-07-15T05:01:29.113814Z","steps":["trace[463573512] 'read index received' (duration: 184.524713ms)","trace[463573512] 'applied index is now lower than readState.Index' (duration: 1.471687ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:01:29.113968Z","caller":"traceutil/trace.go:171","msg":"trace[20628346] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"235.462441ms","start":"2026-07-15T05:01:28.878463Z","end":"2026-07-15T05:01:29.113926Z","steps":["trace[20628346] 'process raft request' (duration: 233.814219ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:01:29.114224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.355518ms","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-07-15T05:01:29.114359Z","caller":"traceutil/trace.go:171","msg":"trace[496493797] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1913; }","duration":"186.552133ms","start":"2026-07-15T05:01:28.927782Z","end":"2026-07-15T05:01:29.114334Z","steps":["trace[496493797] 'agreement among raft nodes before linearized reading' (duration: 186.213195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:06.991525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.264067ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-15T05:02:06.991679Z","caller":"traceutil/trace.go:171","msg":"trace[1953522507] linearizableReadLoop","detail":"{readStateIndex:2165; appliedIndex:2164; }","duration":"390.347002ms","start":"2026-07-15T05:02:06.601278Z","end":"2026-07-15T05:02:06.991625Z","steps":["trace[1953522507] 'read index received' (duration: 57.401µs)","trace[1953522507] 'applied index is now lower than readState.Index' (duration: 390.287781ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T05:02:06.991853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.554946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T05:02:06.992089Z","caller":"traceutil/trace.go:171","msg":"trace[1994755300] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2081; }","duration":"390.843124ms","start":"2026-07-15T05:02:06.601226Z","end":"2026-07-15T05:02:06.99207Z","steps":["trace[1994755300] 'agreement among raft nodes before linearized reading' (duration: 390.535106ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:06.992145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:02:06.601207Z","time spent":"390.928226ms","remote":"127.0.0.1:39322","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-07-15T05:02:06.994671Z","caller":"traceutil/trace.go:171","msg":"trace[1970562587] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"137.95174ms","start":"2026-07-15T05:02:06.856686Z","end":"2026-07-15T05:02:06.994637Z","steps":["trace[1970562587] 'process raft request' (duration: 137.716054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:06.994714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.081571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-07-15T05:02:06.994888Z","caller":"traceutil/trace.go:171","msg":"trace[1832508700] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2082; }","duration":"389.278036ms","start":"2026-07-15T05:02:06.605595Z","end":"2026-07-15T05:02:06.994873Z","steps":["trace[1832508700] 'agreement among raft nodes before linearized reading' (duration: 389.005739ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:06.99502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:02:06.605588Z","time spent":"389.417409ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-15T05:02:09.142619Z","caller":"traceutil/trace.go:171","msg":"trace[44675333] linearizableReadLoop","detail":"{readStateIndex:2176; appliedIndex:2175; }","duration":"128.843536ms","start":"2026-07-15T05:02:09.013751Z","end":"2026-07-15T05:02:09.142594Z","steps":["trace[44675333] 'read index received' (duration: 128.686082ms)","trace[44675333] 'applied index is now lower than readState.Index' (duration: 156.064µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:02:09.142673Z","caller":"traceutil/trace.go:171","msg":"trace[1792823515] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"141.765485ms","start":"2026-07-15T05:02:09.000875Z","end":"2026-07-15T05:02:09.14264Z","steps":["trace[1792823515] 'process raft request' (duration: 141.56527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:09.142856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.083102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-07-15T05:02:09.142866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.449009ms","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-07-15T05:02:09.142901Z","caller":"traceutil/trace.go:171","msg":"trace[1683923776] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2092; }","duration":"129.178184ms","start":"2026-07-15T05:02:09.01371Z","end":"2026-07-15T05:02:09.142889Z","steps":["trace[1683923776] 'agreement among raft nodes before linearized reading' (duration: 129.02461ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:09.142933Z","caller":"traceutil/trace.go:171","msg":"trace[1086247872] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2092; }","duration":"118.559182ms","start":"2026-07-15T05:02:09.024359Z","end":"2026-07-15T05:02:09.142918Z","steps":["trace[1086247872] 'agreement among raft nodes before linearized reading' (duration: 118.414958ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:09.142987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.521737ms","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-07-15T05:02:09.143028Z","caller":"traceutil/trace.go:171","msg":"trace[1716181120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2092; }","duration":"117.575078ms","start":"2026-07-15T05:02:09.025441Z","end":"2026-07-15T05:02:09.143017Z","steps":["trace[1716181120] 'agreement among raft nodes before linearized reading' (duration: 117.486086ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:09.32997Z","caller":"traceutil/trace.go:171","msg":"trace[670308391] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"183.725749ms","start":"2026-07-15T05:02:09.146221Z","end":"2026-07-15T05:02:09.329946Z","steps":["trace[670308391] 'process raft request' (duration: 182.945711ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:09.330758Z","caller":"traceutil/trace.go:171","msg":"trace[1113742180] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"183.744229ms","start":"2026-07-15T05:02:09.146989Z","end":"2026-07-15T05:02:09.330733Z","steps":["trace[1113742180] 'process raft request' (duration: 183.604976ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:09.330948Z","caller":"traceutil/trace.go:171","msg":"trace[1189514820] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2176; }","duration":"159.003489ms","start":"2026-07-15T05:02:09.171929Z","end":"2026-07-15T05:02:09.330932Z","steps":["trace[1189514820] 'read index received' (duration: 157.336519ms)","trace[1189514820] 'applied index is now lower than readState.Index' (duration: 1.66619ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:02:09.33104Z","caller":"traceutil/trace.go:171","msg":"trace[359333296] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"183.965454ms","start":"2026-07-15T05:02:09.147067Z","end":"2026-07-15T05:02:09.331032Z","steps":["trace[359333296] 'process raft request' (duration: 183.632466ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:09.331214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.279247ms","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-07-15T05:02:09.33126Z","caller":"traceutil/trace.go:171","msg":"trace[1820501438] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2096; }","duration":"159.365598ms","start":"2026-07-15T05:02:09.171884Z","end":"2026-07-15T05:02:09.331249Z","steps":["trace[1820501438] 'agreement among raft nodes before linearized reading' (duration: 159.207454ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:09.331472Z","caller":"traceutil/trace.go:171","msg":"trace[1588933227] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"184.248441ms","start":"2026-07-15T05:02:09.147209Z","end":"2026-07-15T05:02:09.331458Z","steps":["trace[1588933227] 'process raft request' (duration: 183.661057ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:11.811928Z","caller":"traceutil/trace.go:171","msg":"trace[1762584794] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"473.396459ms","start":"2026-07-15T05:02:11.338509Z","end":"2026-07-15T05:02:11.811906Z","steps":["trace[1762584794] 'process raft request' (duration: 471.877441ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:11.812033Z","caller":"traceutil/trace.go:171","msg":"trace[293822879] linearizableReadLoop","detail":"{readStateIndex:2188; appliedIndex:2185; }","duration":"472.59223ms","start":"2026-07-15T05:02:11.339416Z","end":"2026-07-15T05:02:11.812008Z","steps":["trace[293822879] 'read index received' (duration: 67.919274ms)","trace[293822879] 'applied index is now lower than readState.Index' (duration: 404.671836ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:02:11.812152Z","caller":"traceutil/trace.go:171","msg":"trace[250417402] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"473.489902ms","start":"2026-07-15T05:02:11.338652Z","end":"2026-07-15T05:02:11.812142Z","steps":["trace[250417402] 'process raft request' (duration: 473.174884ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:11.812054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:02:11.338484Z","time spent":"473.505862ms","remote":"127.0.0.1:39588","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-07-15T05:02:11.812265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:02:11.338626Z","time spent":"473.567743ms","remote":"127.0.0.1:39588","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-07-15T05:02:11.812324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.077117ms","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-07-15T05:02:11.812367Z","caller":"traceutil/trace.go:171","msg":"trace[746691860] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2104; }","duration":"472.157069ms","start":"2026-07-15T05:02:11.340199Z","end":"2026-07-15T05:02:11.812356Z","steps":["trace[746691860] 'agreement among raft nodes before linearized reading' (duration: 472.035076ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:11.812401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:02:11.340177Z","time spent":"472.21721ms","remote":"127.0.0.1:39588","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-07-15T05:02:11.812469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.063251ms","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-07-15T05:02:11.812508Z","caller":"traceutil/trace.go:171","msg":"trace[1293396486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2104; }","duration":"473.147424ms","start":"2026-07-15T05:02:11.33935Z","end":"2026-07-15T05:02:11.812497Z","steps":["trace[1293396486] 'agreement among raft nodes before linearized reading' (duration: 473.032081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:11.812541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:02:11.339329Z","time spent":"473.205694ms","remote":"127.0.0.1:39588","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-07-15T05:02:11.812663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.297322ms","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-07-15T05:02:11.8127Z","caller":"traceutil/trace.go:171","msg":"trace[872967107] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2104; }","duration":"472.333523ms","start":"2026-07-15T05:02:11.340357Z","end":"2026-07-15T05:02:11.812691Z","steps":["trace[872967107] 'agreement among raft nodes before linearized reading' (duration: 472.238311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:11.812732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:02:11.340326Z","time spent":"472.400405ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-15T05:02:11.81284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.608136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T05:02:11.812882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.904889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-15T05:02:11.812673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.513759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-07-15T05:02:11.812921Z","caller":"traceutil/trace.go:171","msg":"trace[1616513244] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:2104; }","duration":"365.978142ms","start":"2026-07-15T05:02:11.446933Z","end":"2026-07-15T05:02:11.812912Z","steps":["trace[1616513244] 'agreement among raft nodes before linearized reading' (duration: 365.887159ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:11.812898Z","caller":"traceutil/trace.go:171","msg":"trace[1352338005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2104; }","duration":"211.690688ms","start":"2026-07-15T05:02:11.601191Z","end":"2026-07-15T05:02:11.812881Z","steps":["trace[1352338005] 'agreement among raft nodes before linearized reading' (duration: 211.607656ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:11.812941Z","caller":"traceutil/trace.go:171","msg":"trace[1142091002] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2104; }","duration":"393.815447ms","start":"2026-07-15T05:02:11.419107Z","end":"2026-07-15T05:02:11.812923Z","steps":["trace[1142091002] 'agreement among raft nodes before linearized reading' (duration: 393.431068ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:11.812953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:02:11.446922Z","time spent":"366.025353ms","remote":"127.0.0.1:39352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.138\" "} {"level":"warn","ts":"2026-07-15T05:02:11.812994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:02:11.419095Z","time spent":"393.887488ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-15T05:02:12.077675Z","caller":"traceutil/trace.go:171","msg":"trace[1347827394] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"260.083641ms","start":"2026-07-15T05:02:11.817568Z","end":"2026-07-15T05:02:12.077651Z","steps":["trace[1347827394] 'process raft request' (duration: 225.231351ms)","trace[1347827394] 'compare' (duration: 34.486141ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:02:12.077828Z","caller":"traceutil/trace.go:171","msg":"trace[1713219833] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"259.896737ms","start":"2026-07-15T05:02:11.817909Z","end":"2026-07-15T05:02:12.077805Z","steps":["trace[1713219833] 'process raft request' (duration: 259.855956ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:12.078009Z","caller":"traceutil/trace.go:171","msg":"trace[1564459764] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"260.379708ms","start":"2026-07-15T05:02:11.817622Z","end":"2026-07-15T05:02:12.078002Z","steps":["trace[1564459764] 'process raft request' (duration: 260.083031ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:12.079405Z","caller":"traceutil/trace.go:171","msg":"trace[31925701] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"260.274766ms","start":"2026-07-15T05:02:11.81912Z","end":"2026-07-15T05:02:12.079395Z","steps":["trace[31925701] 'process raft request' (duration: 259.982019ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:12.079509Z","caller":"traceutil/trace.go:171","msg":"trace[1592077325] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"260.192314ms","start":"2026-07-15T05:02:11.819311Z","end":"2026-07-15T05:02:12.079503Z","steps":["trace[1592077325] 'process raft request' (duration: 259.845045ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:12.25827Z","caller":"traceutil/trace.go:171","msg":"trace[698062390] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2194; }","duration":"175.769073ms","start":"2026-07-15T05:02:12.082481Z","end":"2026-07-15T05:02:12.25825Z","steps":["trace[698062390] 'read index received' (duration: 111.981681ms)","trace[698062390] 'applied index is now lower than readState.Index' (duration: 63.785942ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:02:12.258364Z","caller":"traceutil/trace.go:171","msg":"trace[73422388] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"175.934687ms","start":"2026-07-15T05:02:12.082401Z","end":"2026-07-15T05:02:12.258335Z","steps":["trace[73422388] 'process raft request' (duration: 112.002361ms)","trace[73422388] 'compare' (duration: 63.753242ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T05:02:12.258469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.969038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-15T05:02:12.258476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.28356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T05:02:12.25851Z","caller":"traceutil/trace.go:171","msg":"trace[1216411143] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2110; }","duration":"176.040229ms","start":"2026-07-15T05:02:12.082457Z","end":"2026-07-15T05:02:12.258498Z","steps":["trace[1216411143] 'agreement among raft nodes before linearized reading' (duration: 175.914526ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:12.258549Z","caller":"traceutil/trace.go:171","msg":"trace[497134006] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2110; }","duration":"104.391283ms","start":"2026-07-15T05:02:12.154139Z","end":"2026-07-15T05:02:12.25853Z","steps":["trace[497134006] 'agreement among raft nodes before linearized reading' (duration: 104.239519ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:18.182675Z","caller":"traceutil/trace.go:171","msg":"trace[368149252] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2218; }","duration":"248.794813ms","start":"2026-07-15T05:02:17.933865Z","end":"2026-07-15T05:02:18.18266Z","steps":["trace[368149252] 'read index received' (duration: 248.641909ms)","trace[368149252] 'applied index is now lower than readState.Index' (duration: 152.114µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T05:02:18.183277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.385367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-15T05:02:18.183376Z","caller":"traceutil/trace.go:171","msg":"trace[515482956] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2133; }","duration":"249.52093ms","start":"2026-07-15T05:02:17.933829Z","end":"2026-07-15T05:02:18.18335Z","steps":["trace[515482956] 'agreement among raft nodes before linearized reading' (duration: 249.271654ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:18.183418Z","caller":"traceutil/trace.go:171","msg":"trace[1218019167] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"342.3963ms","start":"2026-07-15T05:02:17.840989Z","end":"2026-07-15T05:02:18.183385Z","steps":["trace[1218019167] 'process raft request' (duration: 341.585631ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:02:18.183569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:02:17.840973Z","time spent":"342.510753ms","remote":"127.0.0.1:39588","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-07-15T05:02:20.450681Z","caller":"traceutil/trace.go:171","msg":"trace[1620963229] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"206.230194ms","start":"2026-07-15T05:02:20.244425Z","end":"2026-07-15T05:02:20.450656Z","steps":["trace[1620963229] 'process raft request' (duration: 206.095269ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:26.152122Z","caller":"traceutil/trace.go:171","msg":"trace[2092493257] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"175.266691ms","start":"2026-07-15T05:02:25.976826Z","end":"2026-07-15T05:02:26.152093Z","steps":["trace[2092493257] 'process raft request' (duration: 175.084356ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:02:36.400825Z","caller":"traceutil/trace.go:171","msg":"trace[1833821896] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"111.662053ms","start":"2026-07-15T05:02:36.28912Z","end":"2026-07-15T05:02:36.400782Z","steps":["trace[1833821896] 'process raft request' (duration: 101.110242ms)","trace[1833821896] 'compare' (duration: 10.404337ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:03:18.599204Z","caller":"traceutil/trace.go:171","msg":"trace[925073862] transaction","detail":"{read_only:false; response_revision:2407; number_of_response:1; }","duration":"251.072294ms","start":"2026-07-15T05:03:18.348099Z","end":"2026-07-15T05:03:18.599171Z","steps":["trace[925073862] 'process raft request' (duration: 250.762177ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:03:18.599083Z","caller":"traceutil/trace.go:171","msg":"trace[555473067] linearizableReadLoop","detail":"{readStateIndex:2505; appliedIndex:2504; }","duration":"183.904387ms","start":"2026-07-15T05:03:18.415151Z","end":"2026-07-15T05:03:18.599055Z","steps":["trace[555473067] 'read index received' (duration: 183.727652ms)","trace[555473067] 'applied index is now lower than readState.Index' (duration: 175.404µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T05:03:18.599438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.277206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-15T05:03:18.599504Z","caller":"traceutil/trace.go:171","msg":"trace[1408402758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2407; }","duration":"184.385629ms","start":"2026-07-15T05:03:18.415105Z","end":"2026-07-15T05:03:18.599491Z","steps":["trace[1408402758] 'agreement among raft nodes before linearized reading' (duration: 184.197675ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:03:57.103922Z","caller":"traceutil/trace.go:171","msg":"trace[708704745] linearizableReadLoop","detail":"{readStateIndex:2728; appliedIndex:2727; }","duration":"126.653705ms","start":"2026-07-15T05:03:56.977229Z","end":"2026-07-15T05:03:57.103883Z","steps":["trace[708704745] 'read index received' (duration: 103.225937ms)","trace[708704745] 'applied index is now lower than readState.Index' (duration: 23.426418ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:03:57.103977Z","caller":"traceutil/trace.go:171","msg":"trace[1580897706] transaction","detail":"{read_only:false; response_revision:2620; number_of_response:1; }","duration":"155.107697ms","start":"2026-07-15T05:03:56.94884Z","end":"2026-07-15T05:03:57.103948Z","steps":["trace[1580897706] 'process raft request' (duration: 131.657818ms)","trace[1580897706] 'compare' (duration: 23.241713ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T05:03:57.104064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.814899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:root-ca-cert-publisher\" ","response":"range_response_count:1 size:672"} {"level":"info","ts":"2026-07-15T05:03:57.104117Z","caller":"traceutil/trace.go:171","msg":"trace[1098094644] range","detail":"{range_begin:/registry/clusterroles/system:controller:root-ca-cert-publisher; range_end:; response_count:1; response_revision:2620; }","duration":"126.907091ms","start":"2026-07-15T05:03:56.977193Z","end":"2026-07-15T05:03:57.1041Z","steps":["trace[1098094644] 'agreement among raft nodes before linearized reading' (duration: 126.809628ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:03:57.104478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.257148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cluster-admin\" ","response":"range_response_count:1 size:679"} {"level":"info","ts":"2026-07-15T05:03:57.104554Z","caller":"traceutil/trace.go:171","msg":"trace[1240452859] range","detail":"{range_begin:/registry/clusterrolebindings/cluster-admin; range_end:; response_count:1; response_revision:2620; }","duration":"116.36104ms","start":"2026-07-15T05:03:56.988173Z","end":"2026-07-15T05:03:57.104534Z","steps":["trace[1240452859] 'agreement among raft nodes before linearized reading' (duration: 115.897159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:04:06.328137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.173838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/default/kubernetes\" ","response":"range_response_count:1 size:704"} {"level":"info","ts":"2026-07-15T05:04:06.328749Z","caller":"traceutil/trace.go:171","msg":"trace[1443846366] range","detail":"{range_begin:/registry/services/specs/default/kubernetes; range_end:; response_count:1; response_revision:2661; }","duration":"355.790754ms","start":"2026-07-15T05:04:05.972931Z","end":"2026-07-15T05:04:06.328722Z","steps":["trace[1443846366] 'range keys from in-memory index tree' (duration: 355.076585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:04:06.328815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:04:05.972914Z","time spent":"355.884656ms","remote":"127.0.0.1:39524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":728,"request content":"key:\"/registry/services/specs/default/kubernetes\" "} {"level":"warn","ts":"2026-07-15T05:04:06.32818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.278193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/\" range_end:\"/registry/rolebindings/envoy-gateway-system0\" limit:500 ","response":"range_response_count:3 size:3302"} {"level":"info","ts":"2026-07-15T05:04:06.329016Z","caller":"traceutil/trace.go:171","msg":"trace[133091022] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/; range_end:/registry/rolebindings/envoy-gateway-system0; response_count:3; response_revision:2661; }","duration":"408.148655ms","start":"2026-07-15T05:04:05.92084Z","end":"2026-07-15T05:04:06.328989Z","steps":["trace[133091022] 'range keys from in-memory index tree' (duration: 407.116289ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:04:06.328238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.843412ms","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-07-15T05:04:06.328364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.034555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/default/\" range_end:\"/registry/statefulsets/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T05:04:06.329455Z","caller":"traceutil/trace.go:171","msg":"trace[2141627929] range","detail":"{range_begin:/registry/statefulsets/default/; range_end:/registry/statefulsets/default0; response_count:0; response_revision:2661; }","duration":"343.07045ms","start":"2026-07-15T05:04:05.986287Z","end":"2026-07-15T05:04:06.329358Z","steps":["trace[2141627929] 'range keys from in-memory index tree' (duration: 341.981383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:04:06.329576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:04:05.986271Z","time spent":"343.281236ms","remote":"127.0.0.1:39790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/default/\" range_end:\"/registry/statefulsets/default0\" limit:500 "} {"level":"warn","ts":"2026-07-15T05:04:06.329111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:04:05.920823Z","time spent":"408.241257ms","remote":"127.0.0.1:39668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":3,"response size":3326,"request content":"key:\"/registry/rolebindings/envoy-gateway-system/\" range_end:\"/registry/rolebindings/envoy-gateway-system0\" limit:500 "} {"level":"info","ts":"2026-07-15T05:04:06.329942Z","caller":"traceutil/trace.go:171","msg":"trace[1546934414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2661; }","duration":"202.610366ms","start":"2026-07-15T05:04:06.127302Z","end":"2026-07-15T05:04:06.329913Z","steps":["trace[1546934414] 'range keys from in-memory index tree' (duration: 200.611616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:04:08.048132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.068738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-rate-limit\" ","response":"range_response_count:1 size:4456"} {"level":"info","ts":"2026-07-15T05:04:08.048216Z","caller":"traceutil/trace.go:171","msg":"trace[743122460] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-rate-limit; range_end:; response_count:1; response_revision:2670; }","duration":"113.191511ms","start":"2026-07-15T05:04:07.935002Z","end":"2026-07-15T05:04:08.048194Z","steps":["trace[743122460] 'range keys from in-memory index tree' (duration: 112.908685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:04:08.048856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.692358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" ","response":"range_response_count:1 size:1036305"} {"level":"info","ts":"2026-07-15T05:04:08.048945Z","caller":"traceutil/trace.go:171","msg":"trace[1154180345] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1; range_end:; response_count:1; response_revision:2670; }","duration":"101.827632ms","start":"2026-07-15T05:04:07.947097Z","end":"2026-07-15T05:04:08.048924Z","steps":["trace[1154180345] 'range keys from in-memory index tree' (duration: 100.786536ms)"],"step_count":1}