{"level":"warn","ts":"2026-08-13T07:56:15.763863Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T07:56:15.764015Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.48:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.48:2380","--initial-cluster=instance=https://199.19.213.48:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.48:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.48:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-13T07:56:15.764111Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T07:56:15.764126Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.48:2380"]} {"level":"info","ts":"2026-08-13T07:56:15.764152Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-13T07:56:15.764904Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.48:2379"]} {"level":"info","ts":"2026-08-13T07:56:15.764988Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.48:2380"],"listen-peer-urls":["https://199.19.213.48:2380"],"advertise-client-urls":["https://199.19.213.48:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.48:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.48:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-13T07:56:15.771654Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.070361ms"} {"level":"info","ts":"2026-08-13T07:56:15.786448Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7317567213c7319d","cluster-id":"d22ed1e1757a8527"} {"level":"info","ts":"2026-08-13T07:56:15.786551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T07:56:15.786572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became follower at term 0"} {"level":"info","ts":"2026-08-13T07:56:15.786583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7317567213c7319d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T07:56:15.78659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became follower at term 1"} {"level":"info","ts":"2026-08-13T07:56:15.78662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d switched to configuration voters=(8293192286784139677)"} {"level":"warn","ts":"2026-08-13T07:56:15.796621Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T07:56:15.798336Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T07:56:15.799656Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-13T07:56:15.803232Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7317567213c7319d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T07:56:15.803659Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7317567213c7319d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T07:56:15.803762Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-13T07:56:15.803811Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-13T07:56:15.803822Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-13T07:56:15.804614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d switched to configuration voters=(8293192286784139677)"} {"level":"info","ts":"2026-08-13T07:56:15.804727Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d22ed1e1757a8527","local-member-id":"7317567213c7319d","added-peer-id":"7317567213c7319d","added-peer-peer-urls":["https://199.19.213.48:2380"]} {"level":"info","ts":"2026-08-13T07:56:15.809594Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-13T07:56:15.809781Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7317567213c7319d","initial-advertise-peer-urls":["https://199.19.213.48:2380"],"listen-peer-urls":["https://199.19.213.48:2380"],"advertise-client-urls":["https://199.19.213.48:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.48:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T07:56:15.809805Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T07:56:15.80991Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.48:2380"} {"level":"info","ts":"2026-08-13T07:56:15.809922Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.48:2380"} {"level":"info","ts":"2026-08-13T07:56:16.586911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T07:56:16.586972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T07:56:16.587007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d received MsgPreVoteResp from 7317567213c7319d at term 1"} {"level":"info","ts":"2026-08-13T07:56:16.587021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became candidate at term 2"} {"level":"info","ts":"2026-08-13T07:56:16.587028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d received MsgVoteResp from 7317567213c7319d at term 2"} {"level":"info","ts":"2026-08-13T07:56:16.587038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became leader at term 2"} {"level":"info","ts":"2026-08-13T07:56:16.587048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7317567213c7319d elected leader 7317567213c7319d at term 2"} {"level":"info","ts":"2026-08-13T07:56:16.588101Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7317567213c7319d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.48:2379]}","request-path":"/0/members/7317567213c7319d/attributes","cluster-id":"d22ed1e1757a8527","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T07:56:16.588245Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T07:56:16.58834Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T07:56:16.588503Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:56:16.58997Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d22ed1e1757a8527","local-member-id":"7317567213c7319d","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:56:16.590075Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:56:16.590103Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:56:16.590741Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T07:56:16.60774Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T07:56:16.607799Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T07:56:16.608708Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.48:2379"} {"level":"warn","ts":"2026-08-13T07:56:18.817286Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3575189575815932534,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-13T07:56:18.921463Z","caller":"traceutil/trace.go:171","msg":"trace[1655444386] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"606.460679ms","start":"2026-08-13T07:56:18.31497Z","end":"2026-08-13T07:56:18.92143Z","steps":["trace[1655444386] 'process raft request' (duration: 606.172818ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:18.922118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.31495Z","time spent":"606.612435ms","remote":"127.0.0.1:50456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:56:19.770185Z","caller":"traceutil/trace.go:171","msg":"trace[1206443427] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:4; }","duration":"1.453015809s","start":"2026-08-13T07:56:18.317146Z","end":"2026-08-13T07:56:19.770161Z","steps":["trace[1206443427] 'read index received' (duration: 604.088389ms)","trace[1206443427] 'applied index is now lower than readState.Index' (duration: 848.92657ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:56:19.770295Z","caller":"traceutil/trace.go:171","msg":"trace[126178299] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.453201566s","start":"2026-08-13T07:56:18.317084Z","end":"2026-08-13T07:56:19.770286Z","steps":["trace[126178299] 'process raft request' (duration: 1.45276492s)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:19.770402Z","caller":"traceutil/trace.go:171","msg":"trace[963009272] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.367651138s","start":"2026-08-13T07:56:18.402711Z","end":"2026-08-13T07:56:19.770362Z","steps":["trace[963009272] 'process raft request' (duration: 1.367424909s)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:19.771062Z","caller":"traceutil/trace.go:171","msg":"trace[1864025358] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.378223151s","start":"2026-08-13T07:56:18.392746Z","end":"2026-08-13T07:56:19.770969Z","steps":["trace[1864025358] 'process raft request' (duration: 1.377262025s)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:19.771083Z","caller":"traceutil/trace.go:171","msg":"trace[1699078059] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.376203225s","start":"2026-08-13T07:56:18.394733Z","end":"2026-08-13T07:56:19.770936Z","steps":["trace[1699078059] 'process raft request' (duration: 1.375357163s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.771213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.394723Z","time spent":"1.376433933s","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T07:56:19.771214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.402696Z","time spent":"1.368344664s","remote":"127.0.0.1:50364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T07:56:19.771243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.392732Z","time spent":"1.378420959s","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:56:19.770456Z","caller":"traceutil/trace.go:171","msg":"trace[560642690] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.375375263s","start":"2026-08-13T07:56:18.395044Z","end":"2026-08-13T07:56:19.77042Z","steps":["trace[560642690] 'process raft request' (duration: 1.375063371s)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:19.77061Z","caller":"traceutil/trace.go:171","msg":"trace[1090170158] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.376709764s","start":"2026-08-13T07:56:18.393889Z","end":"2026-08-13T07:56:19.770598Z","steps":["trace[1090170158] 'process raft request' (duration: 1.376145073s)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:19.770657Z","caller":"traceutil/trace.go:171","msg":"trace[1622830977] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.453477316s","start":"2026-08-13T07:56:18.317162Z","end":"2026-08-13T07:56:19.770639Z","steps":["trace[1622830977] 'process raft request' (duration: 1.452825032s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.771496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.317156Z","time spent":"1.454297707s","remote":"127.0.0.1:50258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:56:19.770628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.404192154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:56:19.771594Z","caller":"traceutil/trace.go:171","msg":"trace[1445848477] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.405228043s","start":"2026-08-13T07:56:18.366343Z","end":"2026-08-13T07:56:19.771571Z","steps":["trace[1445848477] 'agreement among raft nodes before linearized reading' (duration: 1.404157692s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.77074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.453588101s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"warn","ts":"2026-08-13T07:56:19.771804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.366317Z","time spent":"1.405470232s","remote":"127.0.0.1:50292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-13T07:56:19.771884Z","caller":"traceutil/trace.go:171","msg":"trace[713370558] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"1.454698142s","start":"2026-08-13T07:56:18.317124Z","end":"2026-08-13T07:56:19.771822Z","steps":["trace[713370558] 'agreement among raft nodes before linearized reading' (duration: 1.453567399s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.771985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.317117Z","time spent":"1.454821968s","remote":"127.0.0.1:50364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-08-13T07:56:19.770757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315609839s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-13T07:56:19.772108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.393855Z","time spent":"1.377560336s","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:56:19.772116Z","caller":"traceutil/trace.go:171","msg":"trace[971924481] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"1.317008701s","start":"2026-08-13T07:56:18.455088Z","end":"2026-08-13T07:56:19.772096Z","steps":["trace[971924481] 'agreement among raft nodes before linearized reading' (duration: 1.315610719s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.772167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.455062Z","time spent":"1.317090215s","remote":"127.0.0.1:50292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-08-13T07:56:19.770827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.711988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:56:19.772221Z","caller":"traceutil/trace.go:171","msg":"trace[831444394] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:11; }","duration":"482.153282ms","start":"2026-08-13T07:56:19.290056Z","end":"2026-08-13T07:56:19.77221Z","steps":["trace[831444394] 'agreement among raft nodes before linearized reading' (duration: 480.734258ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.772256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:19.29003Z","time spent":"482.214434ms","remote":"127.0.0.1:50560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-08-13T07:56:19.770802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.759671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:56:19.772337Z","caller":"traceutil/trace.go:171","msg":"trace[1987571442] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11; }","duration":"481.363952ms","start":"2026-08-13T07:56:19.29096Z","end":"2026-08-13T07:56:19.772324Z","steps":["trace[1987571442] 'agreement among raft nodes before linearized reading' (duration: 479.761562ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.77238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:19.290897Z","time spent":"481.470066ms","remote":"127.0.0.1:50536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-08-13T07:56:19.770803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.378411218s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:56:19.772474Z","caller":"traceutil/trace.go:171","msg":"trace[1654073953] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.380112152s","start":"2026-08-13T07:56:18.392353Z","end":"2026-08-13T07:56:19.772465Z","steps":["trace[1654073953] 'agreement among raft nodes before linearized reading' (duration: 1.378422779s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.772513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.392346Z","time spent":"1.380146234s","remote":"127.0.0.1:50292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-13T07:56:19.770871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.099336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-7pck4\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-08-13T07:56:19.772602Z","caller":"traceutil/trace.go:171","msg":"trace[562695088] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-7pck4; range_end:; response_count:1; response_revision:11; }","duration":"845.856422ms","start":"2026-08-13T07:56:18.926739Z","end":"2026-08-13T07:56:19.772595Z","steps":["trace[562695088] 'agreement among raft nodes before linearized reading' (duration: 844.103366ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.772623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.926719Z","time spent":"845.897654ms","remote":"127.0.0.1:50456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-7pck4\" "} {"level":"warn","ts":"2026-08-13T07:56:19.770853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.370062169s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:56:19.772728Z","caller":"traceutil/trace.go:171","msg":"trace[829054735] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"1.372010313s","start":"2026-08-13T07:56:18.400703Z","end":"2026-08-13T07:56:19.772713Z","steps":["trace[829054735] 'agreement among raft nodes before linearized reading' (duration: 1.369997997s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.772761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.400686Z","time spent":"1.372065005s","remote":"127.0.0.1:50276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-08-13T07:56:19.770857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.317069Z","time spent":"1.453389084s","remote":"127.0.0.1:50244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:56:19.770911Z","caller":"traceutil/trace.go:171","msg":"trace[1747916871] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.376456744s","start":"2026-08-13T07:56:18.394441Z","end":"2026-08-13T07:56:19.770897Z","steps":["trace[1747916871] 'process raft request' (duration: 1.375626973s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.772985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.394433Z","time spent":"1.378530882s","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T07:56:19.770897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.379554562s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.48\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:56:19.773084Z","caller":"traceutil/trace.go:171","msg":"trace[962963651] range","detail":"{range_begin:/registry/masterleases/199.19.213.48; range_end:; response_count:0; response_revision:11; }","duration":"1.381755336s","start":"2026-08-13T07:56:18.391299Z","end":"2026-08-13T07:56:19.773054Z","steps":["trace[962963651] 'agreement among raft nodes before linearized reading' (duration: 1.379567933s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.773109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.391273Z","time spent":"1.381827757s","remote":"127.0.0.1:50224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.48\" "} {"level":"info","ts":"2026-08-13T07:56:19.770942Z","caller":"traceutil/trace.go:171","msg":"trace[2052309168] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.378112777s","start":"2026-08-13T07:56:18.392821Z","end":"2026-08-13T07:56:19.770933Z","steps":["trace[2052309168] 'process raft request' (duration: 1.377230793s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.771369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.39503Z","time spent":"1.376271166s","remote":"127.0.0.1:50638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T07:56:19.770933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.325205465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:56:19.774546Z","caller":"traceutil/trace.go:171","msg":"trace[2077224631] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.328815182s","start":"2026-08-13T07:56:18.445715Z","end":"2026-08-13T07:56:19.77453Z","steps":["trace[2077224631] 'agreement among raft nodes before linearized reading' (duration: 1.325180635s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:19.774591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.445681Z","time spent":"1.328899715s","remote":"127.0.0.1:50292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-13T07:56:19.77902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:18.39281Z","time spent":"1.38058393s","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:00.369116Z","caller":"traceutil/trace.go:171","msg":"trace[1672686765] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:558; }","duration":"133.159739ms","start":"2026-08-13T07:57:00.235928Z","end":"2026-08-13T07:57:00.369088Z","steps":["trace[1672686765] 'read index received' (duration: 132.897933ms)","trace[1672686765] 'applied index is now lower than readState.Index' (duration: 260.506µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:00.369177Z","caller":"traceutil/trace.go:171","msg":"trace[29032528] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"135.22234ms","start":"2026-08-13T07:57:00.233919Z","end":"2026-08-13T07:57:00.369142Z","steps":["trace[29032528] 'process raft request' (duration: 134.923953ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:00.369268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.320213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T07:57:00.369306Z","caller":"traceutil/trace.go:171","msg":"trace[600096499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:543; }","duration":"133.426536ms","start":"2026-08-13T07:57:00.235869Z","end":"2026-08-13T07:57:00.369296Z","steps":["trace[600096499] 'agreement among raft nodes before linearized reading' (duration: 133.328274ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:01.076978Z","caller":"traceutil/trace.go:171","msg":"trace[510382088] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"703.237669ms","start":"2026-08-13T07:57:00.37372Z","end":"2026-08-13T07:57:01.076957Z","steps":["trace[510382088] 'process raft request' (duration: 703.112756ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:01.077114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:00.373697Z","time spent":"703.342082ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:57:01.077376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.95303ms","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-08-13T07:57:01.077471Z","caller":"traceutil/trace.go:171","msg":"trace[515126407] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:545; }","duration":"414.245028ms","start":"2026-08-13T07:57:00.663206Z","end":"2026-08-13T07:57:01.077451Z","steps":["trace[515126407] 'agreement among raft nodes before linearized reading' (duration: 413.915329ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:01.077539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:00.663185Z","time spent":"414.34164ms","remote":"127.0.0.1:50280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-08-13T07:57:01.077036Z","caller":"traceutil/trace.go:171","msg":"trace[1656091934] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:561; }","duration":"413.719085ms","start":"2026-08-13T07:57:00.663252Z","end":"2026-08-13T07:57:01.076971Z","steps":["trace[1656091934] 'read index received' (duration: 413.701454ms)","trace[1656091934] 'applied index is now lower than readState.Index' (duration: 14.971µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:57:02.035766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.251648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:57:02.035902Z","caller":"traceutil/trace.go:171","msg":"trace[65423060] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:561; }","duration":"957.880573ms","start":"2026-08-13T07:57:01.078005Z","end":"2026-08-13T07:57:02.035886Z","steps":["trace[65423060] 'read index received' (duration: 224.184175ms)","trace[65423060] 'applied index is now lower than readState.Index' (duration: 733.695028ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:02.03599Z","caller":"traceutil/trace.go:171","msg":"trace[1617721989] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.145512135s","start":"2026-08-13T07:57:00.890468Z","end":"2026-08-13T07:57:02.03598Z","steps":["trace[1617721989] 'process raft request' (duration: 411.704304ms)","trace[1617721989] 'compare' (duration: 733.086934ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:57:02.036044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:00.890439Z","time spent":"1.145574907s","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:57:02.036204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.236397428s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.48\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-13T07:57:02.036241Z","caller":"traceutil/trace.go:171","msg":"trace[1782343237] range","detail":"{range_begin:/registry/masterleases/199.19.213.48; range_end:; response_count:1; response_revision:546; }","duration":"1.236482349s","start":"2026-08-13T07:57:00.799747Z","end":"2026-08-13T07:57:02.036229Z","steps":["trace[1782343237] 'agreement among raft nodes before linearized reading' (duration: 1.236417298s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:02.036276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:00.799719Z","time spent":"1.236547321s","remote":"127.0.0.1:50224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.48\" "} {"level":"warn","ts":"2026-08-13T07:57:02.036603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"851.841419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-13T07:57:02.03665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.999996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-13T07:57:02.036681Z","caller":"traceutil/trace.go:171","msg":"trace[661520057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"519.088418ms","start":"2026-08-13T07:57:01.517584Z","end":"2026-08-13T07:57:02.036672Z","steps":["trace[661520057] 'agreement among raft nodes before linearized reading' (duration: 518.989756ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:02.036693Z","caller":"traceutil/trace.go:171","msg":"trace[299233079] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:546; }","duration":"851.965562ms","start":"2026-08-13T07:57:01.184705Z","end":"2026-08-13T07:57:02.03667Z","steps":["trace[299233079] 'agreement among raft nodes before linearized reading' (duration: 851.714076ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:02.036711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:01.517553Z","time spent":"519.15231ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T07:57:02.036748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:01.184679Z","time spent":"852.057784ms","remote":"127.0.0.1:50460","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-08-13T07:57:02.036762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.971935ms","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-08-13T07:57:02.036863Z","caller":"traceutil/trace.go:171","msg":"trace[1802943016] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:546; }","duration":"756.126399ms","start":"2026-08-13T07:57:01.280709Z","end":"2026-08-13T07:57:02.036836Z","steps":["trace[1802943016] 'agreement among raft nodes before linearized reading' (duration: 755.944505ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:02.036914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:01.280676Z","time spent":"756.225881ms","remote":"127.0.0.1:50280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-08-13T07:57:02.037207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.222343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:02.037423Z","caller":"traceutil/trace.go:171","msg":"trace[1710041186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:546; }","duration":"238.530271ms","start":"2026-08-13T07:57:01.798867Z","end":"2026-08-13T07:57:02.037398Z","steps":["trace[1710041186] 'agreement among raft nodes before linearized reading' (duration: 237.747292ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:02.337586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.721336ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-08-13T07:57:02.337749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.037138Z","time spent":"300.599765ms","remote":"127.0.0.1:50224","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-13T07:57:02.338056Z","caller":"traceutil/trace.go:171","msg":"trace[2113090530] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"298.117194ms","start":"2026-08-13T07:57:02.039915Z","end":"2026-08-13T07:57:02.338032Z","steps":["trace[2113090530] 'process raft request' (duration: 298.033772ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:02.338121Z","caller":"traceutil/trace.go:171","msg":"trace[1051892275] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"298.258708ms","start":"2026-08-13T07:57:02.03983Z","end":"2026-08-13T07:57:02.338088Z","steps":["trace[1051892275] 'process raft request' (duration: 297.894719ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:02.338433Z","caller":"traceutil/trace.go:171","msg":"trace[612890056] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:562; }","duration":"299.791605ms","start":"2026-08-13T07:57:02.038586Z","end":"2026-08-13T07:57:02.338378Z","steps":["trace[612890056] 'read index received' (duration: 109.217718ms)","trace[612890056] 'applied index is now lower than readState.Index' (duration: 190.570647ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:57:02.338612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.982899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:02.338689Z","caller":"traceutil/trace.go:171","msg":"trace[1557920444] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"300.114443ms","start":"2026-08-13T07:57:02.038543Z","end":"2026-08-13T07:57:02.338658Z","steps":["trace[1557920444] 'agreement among raft nodes before linearized reading' (duration: 299.974919ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:02.338679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.655883ms","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":"warn","ts":"2026-08-13T07:57:02.338736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.038524Z","time spent":"300.205445ms","remote":"127.0.0.1:50166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-13T07:57:02.338763Z","caller":"traceutil/trace.go:171","msg":"trace[1431953355] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:548; }","duration":"288.815447ms","start":"2026-08-13T07:57:02.049918Z","end":"2026-08-13T07:57:02.338734Z","steps":["trace[1431953355] 'agreement among raft nodes before linearized reading' (duration: 288.638493ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.080834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.080149ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:57:03.080942Z","caller":"traceutil/trace.go:171","msg":"trace[1491795469] linearizableReadLoop","detail":"{readStateIndex:566; appliedIndex:565; }","duration":"707.046309ms","start":"2026-08-13T07:57:02.373877Z","end":"2026-08-13T07:57:03.080924Z","steps":["trace[1491795469] 'read index received' (duration: 327.684104ms)","trace[1491795469] 'applied index is now lower than readState.Index' (duration: 379.360995ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:57:03.081058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.190653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-13T07:57:03.081087Z","caller":"traceutil/trace.go:171","msg":"trace[371287053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:549; }","duration":"707.275825ms","start":"2026-08-13T07:57:02.373801Z","end":"2026-08-13T07:57:03.081077Z","steps":["trace[371287053] 'agreement among raft nodes before linearized reading' (duration: 707.168423ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.081136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.373761Z","time spent":"707.362627ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-13T07:57:03.081457Z","caller":"traceutil/trace.go:171","msg":"trace[1698812534] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"741.094408ms","start":"2026-08-13T07:57:02.340351Z","end":"2026-08-13T07:57:03.081446Z","steps":["trace[1698812534] 'process raft request' (duration: 361.295062ms)","trace[1698812534] 'compare' (duration: 378.912805ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:57:03.081521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.340322Z","time spent":"741.16656ms","remote":"127.0.0.1:50224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:57:03.088658Z","caller":"traceutil/trace.go:171","msg":"trace[883210908] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"567.4243ms","start":"2026-08-13T07:57:02.5212Z","end":"2026-08-13T07:57:03.088624Z","steps":["trace[883210908] 'process raft request' (duration: 567.184684ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.088853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.52117Z","time spent":"567.568744ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:03.089048Z","caller":"traceutil/trace.go:171","msg":"trace[1801568740] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"537.092312ms","start":"2026-08-13T07:57:02.551946Z","end":"2026-08-13T07:57:03.089038Z","steps":["trace[1801568740] 'process raft request' (duration: 536.687582ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.089087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.551923Z","time spent":"537.146363ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:03.089229Z","caller":"traceutil/trace.go:171","msg":"trace[2085023174] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"557.933509ms","start":"2026-08-13T07:57:02.531276Z","end":"2026-08-13T07:57:03.089209Z","steps":["trace[2085023174] 'process raft request' (duration: 557.324785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.089345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.53127Z","time spent":"558.017421ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:03.089451Z","caller":"traceutil/trace.go:171","msg":"trace[1450368599] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"558.650927ms","start":"2026-08-13T07:57:02.530787Z","end":"2026-08-13T07:57:03.089437Z","steps":["trace[1450368599] 'process raft request' (duration: 557.723764ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.089505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.530765Z","time spent":"558.721498ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:03.089514Z","caller":"traceutil/trace.go:171","msg":"trace[597718565] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"523.665905ms","start":"2026-08-13T07:57:02.56584Z","end":"2026-08-13T07:57:03.089506Z","steps":["trace[597718565] 'process raft request' (duration: 522.990269ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.089563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.565799Z","time spent":"523.732257ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:03.089648Z","caller":"traceutil/trace.go:171","msg":"trace[1045152007] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"523.452031ms","start":"2026-08-13T07:57:02.566185Z","end":"2026-08-13T07:57:03.089637Z","steps":["trace[1045152007] 'process raft request' (duration: 522.745273ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.089684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.566155Z","time spent":"523.514711ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:03.089651Z","caller":"traceutil/trace.go:171","msg":"trace[329951988] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"523.132982ms","start":"2026-08-13T07:57:02.566502Z","end":"2026-08-13T07:57:03.089635Z","steps":["trace[329951988] 'process raft request' (duration: 522.480527ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:03.089814Z","caller":"traceutil/trace.go:171","msg":"trace[28836675] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"484.573694ms","start":"2026-08-13T07:57:02.60523Z","end":"2026-08-13T07:57:03.089803Z","steps":["trace[28836675] 'process raft request' (duration: 483.816675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.089871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.605159Z","time spent":"484.694107ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:03.089644Z","caller":"traceutil/trace.go:171","msg":"trace[427387973] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"529.641321ms","start":"2026-08-13T07:57:02.559971Z","end":"2026-08-13T07:57:03.089613Z","steps":["trace[427387973] 'process raft request' (duration: 528.719599ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.089827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.566484Z","time spent":"523.281136ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T07:57:03.089952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.559949Z","time spent":"529.970808ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:03.090238Z","caller":"traceutil/trace.go:171","msg":"trace[458748142] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"477.994863ms","start":"2026-08-13T07:57:02.612233Z","end":"2026-08-13T07:57:03.090228Z","steps":["trace[458748142] 'process raft request' (duration: 477.226154ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.090288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.612207Z","time spent":"478.059775ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:03.095111Z","caller":"traceutil/trace.go:171","msg":"trace[1060964664] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"462.512146ms","start":"2026-08-13T07:57:02.632574Z","end":"2026-08-13T07:57:03.095086Z","steps":["trace[1060964664] 'process raft request' (duration: 457.609948ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.095302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.632537Z","time spent":"462.695001ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:03.107057Z","caller":"traceutil/trace.go:171","msg":"trace[524009151] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"361.078525ms","start":"2026-08-13T07:57:02.745843Z","end":"2026-08-13T07:57:03.106921Z","steps":["trace[524009151] 'process raft request' (duration: 359.854385ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:03.107614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:02.745795Z","time spent":"361.430013ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:06.67832Z","caller":"traceutil/trace.go:171","msg":"trace[1994995217] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"502.851781ms","start":"2026-08-13T07:57:06.175427Z","end":"2026-08-13T07:57:06.678279Z","steps":["trace[1994995217] 'process raft request' (duration: 409.98383ms)","trace[1994995217] 'compare' (duration: 92.754688ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:57:06.678494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:06.175384Z","time spent":"503.020095ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10362,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:57:06.685061Z","caller":"traceutil/trace.go:171","msg":"trace[1295073785] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:684; }","duration":"319.226898ms","start":"2026-08-13T07:57:06.365805Z","end":"2026-08-13T07:57:06.685032Z","steps":["trace[1295073785] 'read index received' (duration: 219.644799ms)","trace[1295073785] 'applied index is now lower than readState.Index' (duration: 99.581369ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:06.685256Z","caller":"traceutil/trace.go:171","msg":"trace[1202159883] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"343.541149ms","start":"2026-08-13T07:57:06.341643Z","end":"2026-08-13T07:57:06.685184Z","steps":["trace[1202159883] 'process raft request' (duration: 343.239202ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:06.68535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.531394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-13T07:57:06.685394Z","caller":"traceutil/trace.go:171","msg":"trace[1863316495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:665; }","duration":"319.643107ms","start":"2026-08-13T07:57:06.36574Z","end":"2026-08-13T07:57:06.685383Z","steps":["trace[1863316495] 'agreement among raft nodes before linearized reading' (duration: 319.438432ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:06.685405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.452399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-13T07:57:06.685447Z","caller":"traceutil/trace.go:171","msg":"trace[1559472433] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:665; }","duration":"312.551361ms","start":"2026-08-13T07:57:06.372885Z","end":"2026-08-13T07:57:06.685436Z","steps":["trace[1559472433] 'agreement among raft nodes before linearized reading' (duration: 312.353826ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:06.685448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:06.365717Z","time spent":"319.718959ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T07:57:06.685479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:06.372862Z","time spent":"312.611742ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-13T07:57:06.685466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:06.341616Z","time spent":"343.755544ms","remote":"127.0.0.1:50234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T07:57:06.685579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.681409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:06.685686Z","caller":"traceutil/trace.go:171","msg":"trace[1608330380] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:665; }","duration":"144.838802ms","start":"2026-08-13T07:57:06.540819Z","end":"2026-08-13T07:57:06.685658Z","steps":["trace[1608330380] 'agreement among raft nodes before linearized reading' (duration: 144.649278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:15.170122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.481313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:15.170253Z","caller":"traceutil/trace.go:171","msg":"trace[1535876728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:726; }","duration":"371.689427ms","start":"2026-08-13T07:57:14.79853Z","end":"2026-08-13T07:57:15.17022Z","steps":["trace[1535876728] 'range keys from in-memory index tree' (duration: 371.37829ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:15.170302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:14.798502Z","time spent":"371.789989ms","remote":"127.0.0.1:50178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-13T07:57:15.170442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.121561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-13T07:57:15.170532Z","caller":"traceutil/trace.go:171","msg":"trace[1747532719] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:726; }","duration":"354.244334ms","start":"2026-08-13T07:57:14.816264Z","end":"2026-08-13T07:57:15.170508Z","steps":["trace[1747532719] 'range keys from in-memory index tree' (duration: 353.899377ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:15.170572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:14.816246Z","time spent":"354.314866ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-13T07:57:15.17067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.340347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-13T07:57:15.170756Z","caller":"traceutil/trace.go:171","msg":"trace[1917338949] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:726; }","duration":"119.49673ms","start":"2026-08-13T07:57:15.05124Z","end":"2026-08-13T07:57:15.170737Z","steps":["trace[1917338949] 'range keys from in-memory index tree' (duration: 119.167364ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:15.17085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.326924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-13T07:57:15.170887Z","caller":"traceutil/trace.go:171","msg":"trace[1377890103] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:726; }","duration":"358.397375ms","start":"2026-08-13T07:57:14.812479Z","end":"2026-08-13T07:57:15.170876Z","steps":["trace[1377890103] 'range keys from in-memory index tree' (duration: 358.178301ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:15.170913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:14.812457Z","time spent":"358.449486ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T07:57:15.170929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.494534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rbhnj\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-08-13T07:57:15.170987Z","caller":"traceutil/trace.go:171","msg":"trace[2138728886] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rbhnj; range_end:; response_count:1; response_revision:726; }","duration":"187.569296ms","start":"2026-08-13T07:57:14.983383Z","end":"2026-08-13T07:57:15.170953Z","steps":["trace[2138728886] 'range keys from in-memory index tree' (duration: 187.340111ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:15.405035Z","caller":"traceutil/trace.go:171","msg":"trace[1078798029] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"230.368464ms","start":"2026-08-13T07:57:15.174638Z","end":"2026-08-13T07:57:15.405006Z","steps":["trace[1078798029] 'process raft request' (duration: 223.151837ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:15.405126Z","caller":"traceutil/trace.go:171","msg":"trace[1500571098] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:748; }","duration":"184.008595ms","start":"2026-08-13T07:57:15.221073Z","end":"2026-08-13T07:57:15.405081Z","steps":["trace[1500571098] 'read index received' (duration: 30.992855ms)","trace[1500571098] 'applied index is now lower than readState.Index' (duration: 153.01456ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:15.405217Z","caller":"traceutil/trace.go:171","msg":"trace[1425903706] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"228.920352ms","start":"2026-08-13T07:57:15.176263Z","end":"2026-08-13T07:57:15.405183Z","steps":["trace[1425903706] 'process raft request' (duration: 228.704457ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:15.40546Z","caller":"traceutil/trace.go:171","msg":"trace[686406226] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"229.521416ms","start":"2026-08-13T07:57:15.175923Z","end":"2026-08-13T07:57:15.405444Z","steps":["trace[686406226] 'process raft request' (duration: 228.939233ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:15.405563Z","caller":"traceutil/trace.go:171","msg":"trace[2122555844] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"221.239465ms","start":"2026-08-13T07:57:15.184315Z","end":"2026-08-13T07:57:15.405555Z","steps":["trace[2122555844] 'process raft request' (duration: 220.697483ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:15.405611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.293651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T07:57:15.40572Z","caller":"traceutil/trace.go:171","msg":"trace[1989762035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:731; }","duration":"184.646318ms","start":"2026-08-13T07:57:15.221011Z","end":"2026-08-13T07:57:15.405658Z","steps":["trace[1989762035] 'agreement among raft nodes before linearized reading' (duration: 184.191969ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:15.821064Z","caller":"traceutil/trace.go:171","msg":"trace[1681657854] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"409.466022ms","start":"2026-08-13T07:57:15.411571Z","end":"2026-08-13T07:57:15.821037Z","steps":["trace[1681657854] 'process raft request' (duration: 389.59334ms)","trace[1681657854] 'compare' (duration: 19.721409ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:57:15.82123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:15.411537Z","time spent":"409.605275ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:57:17.911358Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3575189575815933946,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:57:18.298202Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.036546758s","expected-duration":"1s"} {"level":"info","ts":"2026-08-13T07:57:18.298661Z","caller":"traceutil/trace.go:171","msg":"trace[471728031] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"1.037142791s","start":"2026-08-13T07:57:17.261499Z","end":"2026-08-13T07:57:18.298642Z","steps":["trace[471728031] 'process raft request' (duration: 1.037005878s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:18.299569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:17.261485Z","time spent":"1.037242243s","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:57:18.332216Z","caller":"traceutil/trace.go:171","msg":"trace[993619363] linearizableReadLoop","detail":"{readStateIndex:756; appliedIndex:754; }","duration":"921.083549ms","start":"2026-08-13T07:57:17.411107Z","end":"2026-08-13T07:57:18.33219Z","steps":["trace[993619363] 'read index received' (duration: 887.388934ms)","trace[993619363] 'applied index is now lower than readState.Index' (duration: 33.693535ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:57:18.33253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.408416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-13T07:57:18.332565Z","caller":"traceutil/trace.go:171","msg":"trace[1185528641] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:733; }","duration":"921.510698ms","start":"2026-08-13T07:57:17.411045Z","end":"2026-08-13T07:57:18.332556Z","steps":["trace[1185528641] 'agreement among raft nodes before linearized reading' (duration: 921.335294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:18.332596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:17.411021Z","time spent":"921.56813ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-13T07:57:18.332562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.368685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-13T07:57:18.332645Z","caller":"traceutil/trace.go:171","msg":"trace[1490887874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:733; }","duration":"921.511458ms","start":"2026-08-13T07:57:17.411121Z","end":"2026-08-13T07:57:18.332632Z","steps":["trace[1490887874] 'agreement among raft nodes before linearized reading' (duration: 921.332415ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:18.332723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:17.41109Z","time spent":"921.60444ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-13T07:57:18.332908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.639166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:57:18.332957Z","caller":"traceutil/trace.go:171","msg":"trace[145081250] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:733; }","duration":"107.693877ms","start":"2026-08-13T07:57:18.225251Z","end":"2026-08-13T07:57:18.332944Z","steps":["trace[145081250] 'agreement among raft nodes before linearized reading' (duration: 107.607875ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:18.333004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.509868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-13T07:57:18.333039Z","caller":"traceutil/trace.go:171","msg":"trace[1235882055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:733; }","duration":"921.59191ms","start":"2026-08-13T07:57:17.411438Z","end":"2026-08-13T07:57:18.333029Z","steps":["trace[1235882055] 'agreement among raft nodes before linearized reading' (duration: 921.499628ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:18.333066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:17.411387Z","time spent":"921.672642ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T07:57:18.332817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.34719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T07:57:18.333622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.587345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T07:57:18.333657Z","caller":"traceutil/trace.go:171","msg":"trace[1779690622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:733; }","duration":"508.661467ms","start":"2026-08-13T07:57:17.824985Z","end":"2026-08-13T07:57:18.333647Z","steps":["trace[1779690622] 'agreement among raft nodes before linearized reading' (duration: 507.834749ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:18.333652Z","caller":"traceutil/trace.go:171","msg":"trace[1185803503] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:733; }","duration":"260.215398ms","start":"2026-08-13T07:57:18.073407Z","end":"2026-08-13T07:57:18.333623Z","steps":["trace[1185803503] 'agreement among raft nodes before linearized reading' (duration: 259.36211ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:18.333685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:17.824967Z","time spent":"508.711929ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-13T07:57:34.951527Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3575189575815934241,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-13T07:57:34.993199Z","caller":"traceutil/trace.go:171","msg":"trace[1387691524] linearizableReadLoop","detail":"{readStateIndex:868; appliedIndex:867; }","duration":"544.480908ms","start":"2026-08-13T07:57:34.448697Z","end":"2026-08-13T07:57:34.993177Z","steps":["trace[1387691524] 'read index received' (duration: 544.229164ms)","trace[1387691524] 'applied index is now lower than readState.Index' (duration: 251.024µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:34.993617Z","caller":"traceutil/trace.go:171","msg":"trace[742066243] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"549.572265ms","start":"2026-08-13T07:57:34.443993Z","end":"2026-08-13T07:57:34.993565Z","steps":["trace[742066243] 'process raft request' (duration: 548.983563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:34.993701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.238818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-13T07:57:34.993717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:34.443971Z","time spent":"549.677416ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:57:34.993739Z","caller":"traceutil/trace.go:171","msg":"trace[1442413931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:840; }","duration":"410.285859ms","start":"2026-08-13T07:57:34.583445Z","end":"2026-08-13T07:57:34.993731Z","steps":["trace[1442413931] 'agreement among raft nodes before linearized reading' (duration: 410.132826ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:34.993765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:34.583419Z","time spent":"410.34014ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-13T07:57:34.993889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.191913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-13T07:57:34.993914Z","caller":"traceutil/trace.go:171","msg":"trace[1987369914] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:840; }","duration":"545.246893ms","start":"2026-08-13T07:57:34.448661Z","end":"2026-08-13T07:57:34.993908Z","steps":["trace[1987369914] 'agreement among raft nodes before linearized reading' (duration: 545.159431ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:34.993936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:34.448643Z","time spent":"545.285023ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-13T07:57:38.863751Z","caller":"traceutil/trace.go:171","msg":"trace[1390803727] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"631.486845ms","start":"2026-08-13T07:57:38.23223Z","end":"2026-08-13T07:57:38.863717Z","steps":["trace[1390803727] 'process raft request' (duration: 631.26082ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:38.864194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:38.232202Z","time spent":"631.661127ms","remote":"127.0.0.1:50376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:57:43.033418Z","caller":"traceutil/trace.go:171","msg":"trace[1579195467] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"315.626183ms","start":"2026-08-13T07:57:42.717738Z","end":"2026-08-13T07:57:43.033364Z","steps":["trace[1579195467] 'process raft request' (duration: 315.208716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:43.03382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:42.717701Z","time spent":"315.900538ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:57:43.976378Z","caller":"traceutil/trace.go:171","msg":"trace[406858155] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"210.36908ms","start":"2026-08-13T07:57:43.765969Z","end":"2026-08-13T07:57:43.976338Z","steps":["trace[406858155] 'process raft request' (duration: 71.722202ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:51.034699Z","caller":"traceutil/trace.go:171","msg":"trace[2096882262] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"122.172771ms","start":"2026-08-13T07:57:50.912505Z","end":"2026-08-13T07:57:51.034678Z","steps":["trace[2096882262] 'read index received' (duration: 122.008858ms)","trace[2096882262] 'applied index is now lower than readState.Index' (duration: 163.153µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:51.034874Z","caller":"traceutil/trace.go:171","msg":"trace[1997630408] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"129.045478ms","start":"2026-08-13T07:57:50.905808Z","end":"2026-08-13T07:57:51.034853Z","steps":["trace[1997630408] 'process raft request' (duration: 128.717092ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:51.03492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.388134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:51.034949Z","caller":"traceutil/trace.go:171","msg":"trace[788218091] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:979; }","duration":"122.469456ms","start":"2026-08-13T07:57:50.91247Z","end":"2026-08-13T07:57:51.03494Z","steps":["trace[788218091] 'agreement among raft nodes before linearized reading' (duration: 122.314273ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:57.916676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.938385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:57.91683Z","caller":"traceutil/trace.go:171","msg":"trace[505470725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1042; }","duration":"117.150719ms","start":"2026-08-13T07:57:57.799662Z","end":"2026-08-13T07:57:57.916813Z","steps":["trace[505470725] 'range keys from in-memory index tree' (duration: 116.840674ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:59.498954Z","caller":"traceutil/trace.go:171","msg":"trace[107114127] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1076; }","duration":"280.623422ms","start":"2026-08-13T07:57:59.218305Z","end":"2026-08-13T07:57:59.498929Z","steps":["trace[107114127] 'read index received' (duration: 280.397428ms)","trace[107114127] 'applied index is now lower than readState.Index' (duration: 225.084µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:59.49909Z","caller":"traceutil/trace.go:171","msg":"trace[775874997] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"367.547593ms","start":"2026-08-13T07:57:59.131532Z","end":"2026-08-13T07:57:59.49908Z","steps":["trace[775874997] 'process raft request' (duration: 367.207668ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:59.499197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:59.131508Z","time spent":"367.612424ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:57:59.499404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.10848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-13T07:57:59.499435Z","caller":"traceutil/trace.go:171","msg":"trace[1957817732] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1043; }","duration":"281.178461ms","start":"2026-08-13T07:57:59.218249Z","end":"2026-08-13T07:57:59.499427Z","steps":["trace[1957817732] 'agreement among raft nodes before linearized reading' (duration: 281.060759ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:59.49957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.248354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-13T07:57:59.499613Z","caller":"traceutil/trace.go:171","msg":"trace[1295941707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1043; }","duration":"247.328765ms","start":"2026-08-13T07:57:59.252273Z","end":"2026-08-13T07:57:59.499601Z","steps":["trace[1295941707] 'agreement among raft nodes before linearized reading' (duration: 247.220894ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:59.499633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.21315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-13T07:57:59.49979Z","caller":"traceutil/trace.go:171","msg":"trace[135351858] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1043; }","duration":"235.417614ms","start":"2026-08-13T07:57:59.264352Z","end":"2026-08-13T07:57:59.499769Z","steps":["trace[135351858] 'agreement among raft nodes before linearized reading' (duration: 235.12987ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:59.499804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.473468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T07:57:59.499848Z","caller":"traceutil/trace.go:171","msg":"trace[1687017375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1043; }","duration":"247.573309ms","start":"2026-08-13T07:57:59.252263Z","end":"2026-08-13T07:57:59.499837Z","steps":["trace[1687017375] 'agreement among raft nodes before linearized reading' (duration: 247.126082ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:59.49985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.667163ms","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-08-13T07:57:59.499901Z","caller":"traceutil/trace.go:171","msg":"trace[2055650718] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1043; }","duration":"273.119871ms","start":"2026-08-13T07:57:59.226767Z","end":"2026-08-13T07:57:59.499886Z","steps":["trace[2055650718] 'agreement among raft nodes before linearized reading' (duration: 272.623853ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:59.740504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.388852ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:57:59.740993Z","caller":"traceutil/trace.go:171","msg":"trace[428476555] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"235.18616ms","start":"2026-08-13T07:57:59.505783Z","end":"2026-08-13T07:57:59.740969Z","steps":["trace[428476555] 'process raft request' (duration: 235.127939ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:59.741066Z","caller":"traceutil/trace.go:171","msg":"trace[474976857] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"236.053814ms","start":"2026-08-13T07:57:59.504983Z","end":"2026-08-13T07:57:59.741036Z","steps":["trace[474976857] 'process raft request' (duration: 27.966061ms)","trace[474976857] 'compare' (duration: 207.111307ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:59.74113Z","caller":"traceutil/trace.go:171","msg":"trace[666124027] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"235.81358ms","start":"2026-08-13T07:57:59.505302Z","end":"2026-08-13T07:57:59.741116Z","steps":["trace[666124027] 'process raft request' (duration: 235.490365ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:59.741227Z","caller":"traceutil/trace.go:171","msg":"trace[1313041129] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"235.879851ms","start":"2026-08-13T07:57:59.505338Z","end":"2026-08-13T07:57:59.741218Z","steps":["trace[1313041129] 'process raft request' (duration: 235.504315ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:59.741209Z","caller":"traceutil/trace.go:171","msg":"trace[808141061] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"235.918431ms","start":"2026-08-13T07:57:59.505258Z","end":"2026-08-13T07:57:59.741176Z","steps":["trace[808141061] 'process raft request' (duration: 235.391182ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:58:23.945851Z","caller":"traceutil/trace.go:171","msg":"trace[124464957] linearizableReadLoop","detail":"{readStateIndex:1172; appliedIndex:1171; }","duration":"145.493784ms","start":"2026-08-13T07:58:23.80033Z","end":"2026-08-13T07:58:23.945824Z","steps":["trace[124464957] 'read index received' (duration: 145.22391ms)","trace[124464957] 'applied index is now lower than readState.Index' (duration: 269.094µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:58:23.946212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.86191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:58:23.946278Z","caller":"traceutil/trace.go:171","msg":"trace[1103819947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1132; }","duration":"145.987411ms","start":"2026-08-13T07:58:23.800271Z","end":"2026-08-13T07:58:23.946258Z","steps":["trace[1103819947] 'agreement among raft nodes before linearized reading' (duration: 145.8717ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:58:23.946465Z","caller":"traceutil/trace.go:171","msg":"trace[612687295] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"306.906147ms","start":"2026-08-13T07:58:23.639547Z","end":"2026-08-13T07:58:23.946453Z","steps":["trace[612687295] 'process raft request' (duration: 306.136036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:58:23.946599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:58:23.639523Z","time spent":"306.962359ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:59:05.197207Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3575189575815935209,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:59:05.715336Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3575189575815935209,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:59:06.448895Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3575189575815935209,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:59:07.01335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.815838048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-13T07:59:07.019697Z","caller":"traceutil/trace.go:171","msg":"trace[1060097908] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.822202896s","start":"2026-08-13T07:59:05.197475Z","end":"2026-08-13T07:59:07.019678Z","steps":["trace[1060097908] 'agreement among raft nodes before linearized reading' (duration: 1.815834958s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.019745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:05.197411Z","time spent":"1.822324548s","remote":"127.0.0.1:50178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/13 07:59:07 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-13T07:59:07.435854Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3575189575815935209,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:59:07.437607Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.119183087s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-13T07:59:07.692849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.86085ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:59:07.69299Z","caller":"traceutil/trace.go:171","msg":"trace[1024072018] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"3.374666785s","start":"2026-08-13T07:59:04.318297Z","end":"2026-08-13T07:59:07.692964Z","steps":["trace[1024072018] 'process raft request' (duration: 3.119564812s)","trace[1024072018] 'compare' (duration: 254.339904ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:59:07.693098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:04.318269Z","time spent":"3.374788426s","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:59:07.764362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.987607891s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-13T07:59:07.76519Z","caller":"traceutil/trace.go:171","msg":"trace[1879671768] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.988496691s","start":"2026-08-13T07:59:05.776671Z","end":"2026-08-13T07:59:07.765168Z","steps":["trace[1879671768] 'agreement among raft nodes before linearized reading' (duration: 1.987636791s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.765272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:05.776652Z","time spent":"1.988587813s","remote":"127.0.0.1:50166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/13 07:59:07 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-08-13T07:59:07.864294Z","caller":"traceutil/trace.go:171","msg":"trace[1099661330] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"2.128304397s","start":"2026-08-13T07:59:05.735967Z","end":"2026-08-13T07:59:07.864271Z","steps":["trace[1099661330] 'process raft request' (duration: 2.081266904s)","trace[1099661330] 'compare' (duration: 46.8254ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:59:07.86446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:05.735946Z","time spent":"2.128432629s","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:59:07.864668Z","caller":"traceutil/trace.go:171","msg":"trace[699605047] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"2.087845593s","start":"2026-08-13T07:59:05.776785Z","end":"2026-08-13T07:59:07.86463Z","steps":["trace[699605047] 'process raft request' (duration: 2.087437588s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.864832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:05.776776Z","time spent":"2.087965695s","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:59:07.966744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.242738ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-13T07:59:07.967166Z","caller":"traceutil/trace.go:171","msg":"trace[330867124] linearizableReadLoop","detail":"{readStateIndex:1319; appliedIndex:1314; }","duration":"3.634575176s","start":"2026-08-13T07:59:04.332571Z","end":"2026-08-13T07:59:07.967146Z","steps":["trace[330867124] 'read index received' (duration: 3.105298935s)","trace[330867124] 'applied index is now lower than readState.Index' (duration: 529.274891ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:59:07.967159Z","caller":"traceutil/trace.go:171","msg":"trace[463403729] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"542.719218ms","start":"2026-08-13T07:59:07.424397Z","end":"2026-08-13T07:59:07.967116Z","steps":["trace[463403729] 'process raft request' (duration: 542.492045ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.967342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:07.424237Z","time spent":"543.010441ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:59:07.967397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.274152104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T07:59:07.967412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.634768818s","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-08-13T07:59:07.967442Z","caller":"traceutil/trace.go:171","msg":"trace[632064995] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1270; }","duration":"3.274270075s","start":"2026-08-13T07:59:04.693159Z","end":"2026-08-13T07:59:07.967429Z","steps":["trace[632064995] 'agreement among raft nodes before linearized reading' (duration: 3.274187584s)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:07.96747Z","caller":"traceutil/trace.go:171","msg":"trace[6403479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1270; }","duration":"3.634817999s","start":"2026-08-13T07:59:04.332622Z","end":"2026-08-13T07:59:07.96744Z","steps":["trace[6403479] 'agreement among raft nodes before linearized reading' (duration: 3.634688317s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.967488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:04.693137Z","time spent":"3.274339596s","remote":"127.0.0.1:50502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:59:07.967501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.264103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T07:59:07.967534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.634959431s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-13T07:59:07.967568Z","caller":"traceutil/trace.go:171","msg":"trace[682067804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1270; }","duration":"196.378504ms","start":"2026-08-13T07:59:07.771177Z","end":"2026-08-13T07:59:07.967556Z","steps":["trace[682067804] 'agreement among raft nodes before linearized reading' (duration: 196.266363ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:07.967578Z","caller":"traceutil/trace.go:171","msg":"trace[1080329609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1270; }","duration":"3.635003161s","start":"2026-08-13T07:59:04.332564Z","end":"2026-08-13T07:59:07.967567Z","steps":["trace[1080329609] 'agreement among raft nodes before linearized reading' (duration: 3.634697527s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.967653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:04.332507Z","time spent":"3.635138162s","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T07:59:07.967655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.634999241s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-13T07:59:07.967681Z","caller":"traceutil/trace.go:171","msg":"trace[636443164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1270; }","duration":"3.635032711s","start":"2026-08-13T07:59:04.332641Z","end":"2026-08-13T07:59:07.967674Z","steps":["trace[636443164] 'agreement among raft nodes before linearized reading' (duration: 3.63494703s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.967698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.252397377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:59:07.96774Z","caller":"traceutil/trace.go:171","msg":"trace[589921727] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1270; }","duration":"2.252477497s","start":"2026-08-13T07:59:05.715253Z","end":"2026-08-13T07:59:07.96773Z","steps":["trace[589921727] 'agreement among raft nodes before linearized reading' (duration: 2.252415346s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.967773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.989142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-13T07:59:07.967707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:04.332638Z","time spent":"3.635062942s","remote":"127.0.0.1:50460","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-08-13T07:59:07.967807Z","caller":"traceutil/trace.go:171","msg":"trace[1267024833] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1270; }","duration":"543.077433ms","start":"2026-08-13T07:59:07.424713Z","end":"2026-08-13T07:59:07.967791Z","steps":["trace[1267024833] 'agreement among raft nodes before linearized reading' (duration: 543.018022ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.967834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:07.424704Z","time spent":"543.123423ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T07:59:07.967575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.625423911s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:59:07.967868Z","caller":"traceutil/trace.go:171","msg":"trace[2127975597] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1270; }","duration":"3.625756806s","start":"2026-08-13T07:59:04.342101Z","end":"2026-08-13T07:59:07.967858Z","steps":["trace[2127975597] 'agreement among raft nodes before linearized reading' (duration: 3.625411481s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.967884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.252584269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T07:59:07.967904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:04.342078Z","time spent":"3.625815096s","remote":"127.0.0.1:50400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:59:07.968718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.251991241s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:59:07.969538Z","caller":"traceutil/trace.go:171","msg":"trace[1255476757] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1270; }","duration":"2.252658739s","start":"2026-08-13T07:59:05.715253Z","end":"2026-08-13T07:59:07.967911Z","steps":["trace[1255476757] 'agreement among raft nodes before linearized reading' (duration: 2.252605009s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.971775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:05.715239Z","time spent":"2.256496157s","remote":"127.0.0.1:43502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-08-13T07:59:07.96997Z","caller":"traceutil/trace.go:171","msg":"trace[2045169185] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1270; }","duration":"2.253894874s","start":"2026-08-13T07:59:05.715397Z","end":"2026-08-13T07:59:07.969292Z","steps":["trace[2045169185] 'agreement among raft nodes before linearized reading' (duration: 2.25192175s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.972073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:05.715394Z","time spent":"2.256667389s","remote":"127.0.0.1:43700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:59:07.967773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:05.715231Z","time spent":"2.252533558s","remote":"127.0.0.1:43552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:59:07.9675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:04.332617Z","time spent":"3.634875339s","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-13T07:59:07.970106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.518971982s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:59:07.982749Z","caller":"traceutil/trace.go:171","msg":"trace[2009798646] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1270; }","duration":"1.53163635s","start":"2026-08-13T07:59:06.45108Z","end":"2026-08-13T07:59:07.982716Z","steps":["trace[2009798646] 'agreement among raft nodes before linearized reading' (duration: 1.518968963s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:07.982911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:59:06.451059Z","time spent":"1.531800352s","remote":"127.0.0.1:43748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-08-13T07:59:10.242611Z","caller":"traceutil/trace.go:171","msg":"trace[357096682] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"187.219224ms","start":"2026-08-13T07:59:10.055361Z","end":"2026-08-13T07:59:10.24258Z","steps":["trace[357096682] 'process raft request' (duration: 187.004321ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:10.243052Z","caller":"traceutil/trace.go:171","msg":"trace[1658965038] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"187.337285ms","start":"2026-08-13T07:59:10.0557Z","end":"2026-08-13T07:59:10.243037Z","steps":["trace[1658965038] 'process raft request' (duration: 186.834188ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:10.243127Z","caller":"traceutil/trace.go:171","msg":"trace[806538010] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"186.671187ms","start":"2026-08-13T07:59:10.056447Z","end":"2026-08-13T07:59:10.243118Z","steps":["trace[806538010] 'process raft request' (duration: 186.519755ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:24.008528Z","caller":"traceutil/trace.go:171","msg":"trace[1613566893] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"155.239517ms","start":"2026-08-13T07:59:23.853214Z","end":"2026-08-13T07:59:24.008453Z","steps":["trace[1613566893] 'process raft request' (duration: 155.041715ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:24.460866Z","caller":"traceutil/trace.go:171","msg":"trace[642620609] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"107.485073ms","start":"2026-08-13T07:59:24.353335Z","end":"2026-08-13T07:59:24.46082Z","steps":["trace[642620609] 'process raft request' (duration: 102.845328ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:54.792756Z","caller":"traceutil/trace.go:171","msg":"trace[2009635477] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"206.581528ms","start":"2026-08-13T07:59:54.586157Z","end":"2026-08-13T07:59:54.792739Z","steps":["trace[2009635477] 'process raft request' (duration: 205.546ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:54.792692Z","caller":"traceutil/trace.go:171","msg":"trace[899146144] linearizableReadLoop","detail":"{readStateIndex:1516; appliedIndex:1515; }","duration":"156.328805ms","start":"2026-08-13T07:59:54.636331Z","end":"2026-08-13T07:59:54.79266Z","steps":["trace[899146144] 'read index received' (duration: 155.311348ms)","trace[899146144] 'applied index is now lower than readState.Index' (duration: 1.016247ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:59:54.793035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.681089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-13T07:59:54.79323Z","caller":"traceutil/trace.go:171","msg":"trace[933367694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1457; }","duration":"156.934538ms","start":"2026-08-13T07:59:54.636267Z","end":"2026-08-13T07:59:54.793201Z","steps":["trace[933367694] 'agreement among raft nodes before linearized reading' (duration: 156.519462ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:00:02.943725Z","caller":"traceutil/trace.go:171","msg":"trace[216264745] linearizableReadLoop","detail":"{readStateIndex:1551; appliedIndex:1550; }","duration":"144.041734ms","start":"2026-08-13T08:00:02.799661Z","end":"2026-08-13T08:00:02.943703Z","steps":["trace[216264745] 'read index received' (duration: 143.805166ms)","trace[216264745] 'applied index is now lower than readState.Index' (duration: 235.618µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:00:02.94409Z","caller":"traceutil/trace.go:171","msg":"trace[1262904698] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"147.103364ms","start":"2026-08-13T08:00:02.796976Z","end":"2026-08-13T08:00:02.944079Z","steps":["trace[1262904698] 'process raft request' (duration: 146.580605ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:00:02.944276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.598494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:00:02.944306Z","caller":"traceutil/trace.go:171","msg":"trace[1235581216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1490; }","duration":"144.671657ms","start":"2026-08-13T08:00:02.799627Z","end":"2026-08-13T08:00:02.944299Z","steps":["trace[1235581216] 'agreement among raft nodes before linearized reading' (duration: 144.606784ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:00:02.944609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.764178ms","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-08-13T08:00:02.944732Z","caller":"traceutil/trace.go:171","msg":"trace[1307731505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1490; }","duration":"118.952284ms","start":"2026-08-13T08:00:02.825755Z","end":"2026-08-13T08:00:02.944708Z","steps":["trace[1307731505] 'agreement among raft nodes before linearized reading' (duration: 118.614762ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:00:21.205372Z","caller":"traceutil/trace.go:171","msg":"trace[76794657] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"100.807431ms","start":"2026-08-13T08:00:21.104525Z","end":"2026-08-13T08:00:21.205332Z","steps":["trace[76794657] 'process raft request' (duration: 40.135248ms)","trace[76794657] 'compare' (duration: 60.458035ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:00:30.031787Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3575189575815936737,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-13T08:00:30.365591Z","caller":"traceutil/trace.go:171","msg":"trace[1918555442] transaction","detail":"{read_only:false; response_revision:1582; number_of_response:1; }","duration":"975.768258ms","start":"2026-08-13T08:00:29.389798Z","end":"2026-08-13T08:00:30.365566Z","steps":["trace[1918555442] 'process raft request' (duration: 951.912006ms)","trace[1918555442] 'compare' (duration: 21.326162ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:00:30.365742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:00:29.389775Z","time spent":"975.901052ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:00:30.368003Z","caller":"traceutil/trace.go:171","msg":"trace[501844301] linearizableReadLoop","detail":"{readStateIndex:1649; appliedIndex:1647; }","duration":"837.079662ms","start":"2026-08-13T08:00:29.530904Z","end":"2026-08-13T08:00:30.367984Z","steps":["trace[501844301] 'read index received' (duration: 811.04842ms)","trace[501844301] 'applied index is now lower than readState.Index' (duration: 26.030172ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:00:30.368225Z","caller":"traceutil/trace.go:171","msg":"trace[1668698269] transaction","detail":"{read_only:false; response_revision:1583; number_of_response:1; }","duration":"707.120023ms","start":"2026-08-13T08:00:29.661093Z","end":"2026-08-13T08:00:30.368213Z","steps":["trace[1668698269] 'process raft request' (duration: 706.796623ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:00:30.368323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:00:29.661059Z","time spent":"707.188855ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:00:30.368563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.897519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2918"} {"level":"warn","ts":"2026-08-13T08:00:30.36863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.733262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-08-13T08:00:30.368663Z","caller":"traceutil/trace.go:171","msg":"trace[1092954384] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1583; }","duration":"837.798284ms","start":"2026-08-13T08:00:29.530854Z","end":"2026-08-13T08:00:30.368652Z","steps":["trace[1092954384] 'agreement among raft nodes before linearized reading' (duration: 837.67233ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:00:30.368639Z","caller":"traceutil/trace.go:171","msg":"trace[12261218] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1583; }","duration":"833.014773ms","start":"2026-08-13T08:00:29.535607Z","end":"2026-08-13T08:00:30.368622Z","steps":["trace[12261218] 'agreement among raft nodes before linearized reading' (duration: 832.807226ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:00:30.36869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:00:29.530832Z","time spent":"837.850776ms","remote":"127.0.0.1:50652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":3783,"request content":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-08-13T08:00:30.368707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:00:29.535597Z","time spent":"833.099615ms","remote":"127.0.0.1:50680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2941,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "}