{"level":"warn","ts":"2026-08-07T04:28:33.994452Z","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-07T04:28:33.994545Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-07T04:28:33.994617Z","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-07T04:28:33.994625Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-08-07T04:28:33.994711Z","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-07T04:28:33.995429Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-08-07T04:28:33.995514Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-07T04:28:34.001049Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.240353ms"} {"level":"info","ts":"2026-08-07T04:28:34.016644Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-08-07T04:28:34.016722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-08-07T04:28:34.016742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-08-07T04:28:34.01675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-07T04:28:34.016759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-08-07T04:28:34.016813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-08-07T04:28:34.02254Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-07T04:28:34.023947Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-07T04:28:34.026494Z","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-07T04:28:34.030131Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-07T04:28:34.030382Z","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-07T04:28:34.030377Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-07T04:28:34.030464Z","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-07T04:28:34.03069Z","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-07T04:28:34.035174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-08-07T04:28:34.036982Z","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-07T04:28:34.037219Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-08-07T04:28:34.037288Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-08-07T04:28:34.037367Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-08-07T04:28:34.03738Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-07T04:28:34.037414Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-07T04:28:34.917029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-08-07T04:28:34.917073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-08-07T04:28:34.917096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-08-07T04:28:34.917107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-08-07T04:28:34.917112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-08-07T04:28:34.917121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-08-07T04:28:34.917127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-08-07T04:28:34.918107Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T04:28:34.918708Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-08-07T04:28:34.918719Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-07T04:28:34.918747Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-07T04:28:34.91897Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-07T04:28:34.919101Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-07T04:28:34.919251Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T04:28:34.919443Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T04:28:34.919493Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T04:28:34.921033Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-07T04:28:34.921932Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"warn","ts":"2026-08-07T04:28:39.477624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.186531096s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-07T04:28:39.477765Z","caller":"traceutil/trace.go:171","msg":"trace[747461680] transaction","detail":"{read_only:false; response_revision:170; number_of_response:1; }","duration":"2.009298289s","start":"2026-08-07T04:28:37.468448Z","end":"2026-08-07T04:28:39.477746Z","steps":["trace[747461680] 'process raft request' (duration: 822.15001ms)","trace[747461680] 'compare' (duration: 1.186392683s)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:28:39.477838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:37.468429Z","time spent":"2.009385271s","remote":"127.0.0.1:54050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":685,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:28:39.531704Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.241004053s","expected-duration":"1s"} {"level":"info","ts":"2026-08-07T04:28:39.532078Z","caller":"traceutil/trace.go:171","msg":"trace[958276912] linearizableReadLoop","detail":"{readStateIndex:176; appliedIndex:174; }","duration":"1.290468059s","start":"2026-08-07T04:28:38.241551Z","end":"2026-08-07T04:28:39.532019Z","steps":["trace[958276912] 'read index received' (duration: 48.988755ms)","trace[958276912] 'applied index is now lower than readState.Index' (duration: 1.241478244s)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:28:39.532192Z","caller":"traceutil/trace.go:171","msg":"trace[1673563450] transaction","detail":"{read_only:false; response_revision:171; number_of_response:1; }","duration":"1.73658063s","start":"2026-08-07T04:28:37.795598Z","end":"2026-08-07T04:28:39.532179Z","steps":["trace[1673563450] 'process raft request' (duration: 1.736300614s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:39.532322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.254335321s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-07T04:28:39.532401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:37.795572Z","time spent":"1.736668233s","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:28:39.532397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290800686s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-07T04:28:39.532479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252270804s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-08-07T04:28:39.532533Z","caller":"traceutil/trace.go:171","msg":"trace[261627298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:171; }","duration":"1.252359666s","start":"2026-08-07T04:28:38.280161Z","end":"2026-08-07T04:28:39.532521Z","steps":["trace[261627298] 'agreement among raft nodes before linearized reading' (duration: 1.252277054s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:39.532577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:38.280139Z","time spent":"1.252423958s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-07T04:28:39.532486Z","caller":"traceutil/trace.go:171","msg":"trace[590178721] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:171; }","duration":"1.290949879s","start":"2026-08-07T04:28:38.241513Z","end":"2026-08-07T04:28:39.532463Z","steps":["trace[590178721] 'agreement among raft nodes before linearized reading' (duration: 1.290765276s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:39.532636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:38.241494Z","time spent":"1.291127244s","remote":"127.0.0.1:53662","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-07T04:28:39.532411Z","caller":"traceutil/trace.go:171","msg":"trace[1622445378] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:171; }","duration":"1.254459194s","start":"2026-08-07T04:28:38.277932Z","end":"2026-08-07T04:28:39.532391Z","steps":["trace[1622445378] 'agreement among raft nodes before linearized reading' (duration: 1.25428257s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:39.532775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:38.277917Z","time spent":"1.254840383s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-07T04:28:41.27299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.662304613s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-07T04:28:41.273252Z","caller":"traceutil/trace.go:171","msg":"trace[2091701983] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"1.163939637s","start":"2026-08-07T04:28:40.109296Z","end":"2026-08-07T04:28:41.273236Z","steps":["trace[2091701983] 'process raft request' (duration: 1.163891186s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:41.273311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:40.109268Z","time spent":"1.164016779s","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:28:41.273487Z","caller":"traceutil/trace.go:171","msg":"trace[220955920] transaction","detail":"{read_only:false; response_revision:173; number_of_response:1; }","duration":"1.736493458s","start":"2026-08-07T04:28:39.536982Z","end":"2026-08-07T04:28:41.273476Z","steps":["trace[220955920] 'process raft request' (duration: 73.435558ms)","trace[220955920] 'compare' (duration: 1.661605498s)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:28:41.273538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:39.536964Z","time spent":"1.736547609s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:28:41.273733Z","caller":"traceutil/trace.go:171","msg":"trace[97420595] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"1.735981816s","start":"2026-08-07T04:28:39.53774Z","end":"2026-08-07T04:28:41.273722Z","steps":["trace[97420595] 'process raft request' (duration: 1.735354142s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:41.273782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:39.537733Z","time spent":"1.736022147s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:28:41.273838Z","caller":"traceutil/trace.go:171","msg":"trace[1195316592] linearizableReadLoop","detail":"{readStateIndex:179; appliedIndex:177; }","duration":"1.71405118s","start":"2026-08-07T04:28:39.559765Z","end":"2026-08-07T04:28:41.273816Z","steps":["trace[1195316592] 'read index received' (duration: 50.53383ms)","trace[1195316592] 'applied index is now lower than readState.Index' (duration: 1.6635143s)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:28:41.274027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.714253464s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-account-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-07T04:28:41.274069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.58208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:28:41.274102Z","caller":"traceutil/trace.go:171","msg":"trace[715414172] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:175; }","duration":"732.659322ms","start":"2026-08-07T04:28:40.541432Z","end":"2026-08-07T04:28:41.274092Z","steps":["trace[715414172] 'agreement among raft nodes before linearized reading' (duration: 732.608741ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:41.274129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:40.541407Z","time spent":"732.715824ms","remote":"127.0.0.1:53662","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-07T04:28:41.274165Z","caller":"traceutil/trace.go:171","msg":"trace[471831619] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-account-controller; range_end:; response_count:0; response_revision:175; }","duration":"1.714332796s","start":"2026-08-07T04:28:39.559716Z","end":"2026-08-07T04:28:41.274049Z","steps":["trace[471831619] 'agreement among raft nodes before linearized reading' (duration: 1.714269395s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:41.27421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:39.559696Z","time spent":"1.714495779s","remote":"127.0.0.1:54050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:controller:service-account-controller\" "} {"level":"warn","ts":"2026-08-07T04:28:42.14181Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830514158952856,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-07T04:28:42.528952Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.251061607s","expected-duration":"1s"} {"level":"info","ts":"2026-08-07T04:28:42.534121Z","caller":"traceutil/trace.go:171","msg":"trace[197587960] linearizableReadLoop","detail":"{readStateIndex:181; appliedIndex:180; }","duration":"892.627662ms","start":"2026-08-07T04:28:41.641462Z","end":"2026-08-07T04:28:42.53409Z","steps":["trace[197587960] 'read index received' (duration: 887.857969ms)","trace[197587960] 'applied index is now lower than readState.Index' (duration: 4.768443ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:28:42.534234Z","caller":"traceutil/trace.go:171","msg":"trace[1486438768] transaction","detail":"{read_only:false; response_revision:176; number_of_response:1; }","duration":"1.256511754s","start":"2026-08-07T04:28:41.277678Z","end":"2026-08-07T04:28:42.53419Z","steps":["trace[1486438768] 'process raft request' (duration: 1.251604699s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:42.534379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:41.277629Z","time spent":"1.256685499s","remote":"127.0.0.1:54050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":662,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:28:42.534842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.825236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:28:42.534914Z","caller":"traceutil/trace.go:171","msg":"trace[1276869190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:176; }","duration":"893.470891ms","start":"2026-08-07T04:28:41.641415Z","end":"2026-08-07T04:28:42.534886Z","steps":["trace[1276869190] 'agreement among raft nodes before linearized reading' (duration: 892.802526ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:42.535181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:41.641393Z","time spent":"893.757156ms","remote":"127.0.0.1:53662","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-07T04:28:44.702395Z","caller":"traceutil/trace.go:171","msg":"trace[2056909983] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"118.39303ms","start":"2026-08-07T04:28:44.583969Z","end":"2026-08-07T04:28:44.702362Z","steps":["trace[2056909983] 'process raft request' (duration: 55.294043ms)","trace[2056909983] 'compare' (duration: 62.999525ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:28:45.380983Z","caller":"traceutil/trace.go:171","msg":"trace[1855395755] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"135.727584ms","start":"2026-08-07T04:28:45.245229Z","end":"2026-08-07T04:28:45.380956Z","steps":["trace[1855395755] 'process raft request' (duration: 135.55917ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.381061Z","caller":"traceutil/trace.go:171","msg":"trace[2013892686] transaction","detail":"{read_only:false; number_of_response:0; response_revision:281; }","duration":"120.162095ms","start":"2026-08-07T04:28:45.260854Z","end":"2026-08-07T04:28:45.381016Z","steps":["trace[2013892686] 'process raft request' (duration: 120.040412ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.381199Z","caller":"traceutil/trace.go:171","msg":"trace[1333698207] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"103.069117ms","start":"2026-08-07T04:28:45.278091Z","end":"2026-08-07T04:28:45.38116Z","steps":["trace[1333698207] 'process raft request' (duration: 102.893022ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.381252Z","caller":"traceutil/trace.go:171","msg":"trace[164134088] transaction","detail":"{read_only:false; number_of_response:0; response_revision:281; }","duration":"103.410953ms","start":"2026-08-07T04:28:45.277832Z","end":"2026-08-07T04:28:45.381243Z","steps":["trace[164134088] 'process raft request' (duration: 103.129797ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.381372Z","caller":"traceutil/trace.go:171","msg":"trace[1953073489] transaction","detail":"{read_only:false; number_of_response:0; response_revision:281; }","duration":"103.841633ms","start":"2026-08-07T04:28:45.277523Z","end":"2026-08-07T04:28:45.381364Z","steps":["trace[1953073489] 'process raft request' (duration: 103.408233ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.381444Z","caller":"traceutil/trace.go:171","msg":"trace[683502229] transaction","detail":"{read_only:false; number_of_response:0; response_revision:282; }","duration":"102.402912ms","start":"2026-08-07T04:28:45.279017Z","end":"2026-08-07T04:28:45.38142Z","steps":["trace[683502229] 'process raft request' (duration: 102.027703ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.381496Z","caller":"traceutil/trace.go:171","msg":"trace[594484124] transaction","detail":"{read_only:false; number_of_response:0; response_revision:282; }","duration":"103.23331ms","start":"2026-08-07T04:28:45.278251Z","end":"2026-08-07T04:28:45.381485Z","steps":["trace[594484124] 'process raft request' (duration: 102.77138ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.381649Z","caller":"traceutil/trace.go:171","msg":"trace[1347646792] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"135.453227ms","start":"2026-08-07T04:28:45.246182Z","end":"2026-08-07T04:28:45.381635Z","steps":["trace[1347646792] 'process raft request' (duration: 134.677061ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.476561Z","caller":"traceutil/trace.go:171","msg":"trace[97904274] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"174.982558ms","start":"2026-08-07T04:28:45.301554Z","end":"2026-08-07T04:28:45.476536Z","steps":["trace[97904274] 'process raft request' (duration: 174.875016ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.716201Z","caller":"traceutil/trace.go:171","msg":"trace[1178120110] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"235.142502ms","start":"2026-08-07T04:28:45.481033Z","end":"2026-08-07T04:28:45.716175Z","steps":["trace[1178120110] 'process raft request' (duration: 235.099461ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.716171Z","caller":"traceutil/trace.go:171","msg":"trace[883103985] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"237.130965ms","start":"2026-08-07T04:28:45.479007Z","end":"2026-08-07T04:28:45.716138Z","steps":["trace[883103985] 'process raft request' (duration: 145.464247ms)","trace[883103985] 'compare' (duration: 91.551625ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:28:45.71625Z","caller":"traceutil/trace.go:171","msg":"trace[816987248] linearizableReadLoop","detail":"{readStateIndex:297; appliedIndex:296; }","duration":"235.821557ms","start":"2026-08-07T04:28:45.480406Z","end":"2026-08-07T04:28:45.716228Z","steps":["trace[816987248] 'read index received' (duration: 144.13368ms)","trace[816987248] 'applied index is now lower than readState.Index' (duration: 91.685097ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:28:45.716421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.980671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-08-07T04:28:45.716461Z","caller":"traceutil/trace.go:171","msg":"trace[774620686] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:287; }","duration":"236.090193ms","start":"2026-08-07T04:28:45.48036Z","end":"2026-08-07T04:28:45.71645Z","steps":["trace[774620686] 'agreement among raft nodes before linearized reading' (duration: 235.94543ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.910793Z","caller":"traceutil/trace.go:171","msg":"trace[127955347] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"184.633441ms","start":"2026-08-07T04:28:45.726142Z","end":"2026-08-07T04:28:45.910775Z","steps":["trace[127955347] 'process raft request' (duration: 184.544449ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.91084Z","caller":"traceutil/trace.go:171","msg":"trace[337539767] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"189.282788ms","start":"2026-08-07T04:28:45.721527Z","end":"2026-08-07T04:28:45.910809Z","steps":["trace[337539767] 'process raft request' (duration: 188.904001ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:45.911584Z","caller":"traceutil/trace.go:171","msg":"trace[259601358] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"137.284145ms","start":"2026-08-07T04:28:45.774273Z","end":"2026-08-07T04:28:45.911558Z","steps":["trace[259601358] 'process raft request' (duration: 137.170803ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:46.146732Z","caller":"traceutil/trace.go:171","msg":"trace[1159533220] linearizableReadLoop","detail":"{readStateIndex:303; appliedIndex:302; }","duration":"170.484477ms","start":"2026-08-07T04:28:45.976226Z","end":"2026-08-07T04:28:46.14671Z","steps":["trace[1159533220] 'read index received' (duration: 118.036714ms)","trace[1159533220] 'applied index is now lower than readState.Index' (duration: 52.446673ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:28:46.146768Z","caller":"traceutil/trace.go:171","msg":"trace[654200328] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"227.438135ms","start":"2026-08-07T04:28:45.919277Z","end":"2026-08-07T04:28:46.146715Z","steps":["trace[654200328] 'process raft request' (duration: 174.939382ms)","trace[654200328] 'compare' (duration: 52.317419ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:28:46.146865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.62876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:28:46.147534Z","caller":"traceutil/trace.go:171","msg":"trace[1184768821] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:292; }","duration":"171.324925ms","start":"2026-08-07T04:28:45.976183Z","end":"2026-08-07T04:28:46.147508Z","steps":["trace[1184768821] 'agreement among raft nodes before linearized reading' (duration: 170.600309ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:46.496442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.043732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-07T04:28:46.496746Z","caller":"traceutil/trace.go:171","msg":"trace[960475343] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"321.973829ms","start":"2026-08-07T04:28:46.174731Z","end":"2026-08-07T04:28:46.496705Z","steps":["trace[960475343] 'process raft request' (duration: 201.592321ms)","trace[960475343] 'compare' (duration: 119.778546ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:28:46.496784Z","caller":"traceutil/trace.go:171","msg":"trace[115705005] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"305.881664ms","start":"2026-08-07T04:28:46.190871Z","end":"2026-08-07T04:28:46.496753Z","steps":["trace[115705005] 'process raft request' (duration: 305.66571ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:46.496975Z","caller":"traceutil/trace.go:171","msg":"trace[914131240] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"279.752958ms","start":"2026-08-07T04:28:46.217174Z","end":"2026-08-07T04:28:46.496927Z","steps":["trace[914131240] 'process raft request' (duration: 279.670067ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:46.497094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:46.190856Z","time spent":"306.16752ms","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:28:46.497132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:46.174707Z","time spent":"322.181424ms","remote":"127.0.0.1:53760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:28:46.497314Z","caller":"traceutil/trace.go:171","msg":"trace[603264599] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"304.427254ms","start":"2026-08-07T04:28:46.19285Z","end":"2026-08-07T04:28:46.497277Z","steps":["trace[603264599] 'process raft request' (duration: 303.727019ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:46.497382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:46.192835Z","time spent":"304.515046ms","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:28:46.497528Z","caller":"traceutil/trace.go:171","msg":"trace[2096138499] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"303.669738ms","start":"2026-08-07T04:28:46.193849Z","end":"2026-08-07T04:28:46.497519Z","steps":["trace[2096138499] 'process raft request' (duration: 302.751129ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:46.497609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:46.193833Z","time spent":"303.724809ms","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:28:46.497741Z","caller":"traceutil/trace.go:171","msg":"trace[943317597] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"303.846892ms","start":"2026-08-07T04:28:46.193886Z","end":"2026-08-07T04:28:46.497733Z","steps":["trace[943317597] 'process raft request' (duration: 302.787779ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:46.497888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:46.193858Z","time spent":"303.915613ms","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-07T04:28:46.498061Z","caller":"traceutil/trace.go:171","msg":"trace[1463640493] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"281.024815ms","start":"2026-08-07T04:28:46.217018Z","end":"2026-08-07T04:28:46.498043Z","steps":["trace[1463640493] 'process raft request' (duration: 279.775249ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:46.498274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.95995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:28:46.498319Z","caller":"traceutil/trace.go:171","msg":"trace[546004071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:297; }","duration":"324.043752ms","start":"2026-08-07T04:28:46.174265Z","end":"2026-08-07T04:28:46.498308Z","steps":["trace[546004071] 'agreement among raft nodes before linearized reading' (duration: 323.93058ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:46.498348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:46.17425Z","time spent":"324.091743ms","remote":"127.0.0.1:53662","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-07T04:28:46.498613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.352884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-08-07T04:28:46.498676Z","caller":"traceutil/trace.go:171","msg":"trace[665708250] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:297; }","duration":"306.414425ms","start":"2026-08-07T04:28:46.192229Z","end":"2026-08-07T04:28:46.498644Z","steps":["trace[665708250] 'agreement among raft nodes before linearized reading' (duration: 306.330423ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:46.498706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:28:46.192217Z","time spent":"306.482347ms","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5359,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"info","ts":"2026-08-07T04:28:46.498092Z","caller":"traceutil/trace.go:171","msg":"trace[132286308] linearizableReadLoop","detail":"{readStateIndex:310; appliedIndex:305; }","duration":"284.452898ms","start":"2026-08-07T04:28:46.213623Z","end":"2026-08-07T04:28:46.498076Z","steps":["trace[132286308] 'read index received' (duration: 162.819533ms)","trace[132286308] 'applied index is now lower than readState.Index' (duration: 121.631825ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:28:48.029194Z","caller":"traceutil/trace.go:171","msg":"trace[2043589901] linearizableReadLoop","detail":"{readStateIndex:341; appliedIndex:340; }","duration":"117.30031ms","start":"2026-08-07T04:28:47.911867Z","end":"2026-08-07T04:28:48.029168Z","steps":["trace[2043589901] 'read index received' (duration: 117.110426ms)","trace[2043589901] 'applied index is now lower than readState.Index' (duration: 189.174µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:28:48.02925Z","caller":"traceutil/trace.go:171","msg":"trace[1244667640] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"117.842771ms","start":"2026-08-07T04:28:47.911373Z","end":"2026-08-07T04:28:48.029215Z","steps":["trace[1244667640] 'process raft request' (duration: 117.662068ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:28:48.029318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.432763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-07T04:28:48.029359Z","caller":"traceutil/trace.go:171","msg":"trace[2050499845] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:326; }","duration":"117.488344ms","start":"2026-08-07T04:28:47.911859Z","end":"2026-08-07T04:28:48.029347Z","steps":["trace[2050499845] 'agreement among raft nodes before linearized reading' (duration: 117.405822ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:28:55.768892Z","caller":"traceutil/trace.go:171","msg":"trace[1369534082] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"178.029503ms","start":"2026-08-07T04:28:55.590835Z","end":"2026-08-07T04:28:55.768865Z","steps":["trace[1369534082] 'process raft request' (duration: 130.416273ms)","trace[1369534082] 'compare' (duration: 47.436856ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:29:18.294046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.339786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:29:18.294134Z","caller":"traceutil/trace.go:171","msg":"trace[507219497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"272.47615ms","start":"2026-08-07T04:29:18.021641Z","end":"2026-08-07T04:29:18.294117Z","steps":["trace[507219497] 'range keys from in-memory index tree' (duration: 272.277505ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:23.277829Z","caller":"traceutil/trace.go:171","msg":"trace[1800881504] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"139.456435ms","start":"2026-08-07T04:29:23.13835Z","end":"2026-08-07T04:29:23.277806Z","steps":["trace[1800881504] 'read index received' (duration: 136.847104ms)","trace[1800881504] 'applied index is now lower than readState.Index' (duration: 2.608601ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:23.277909Z","caller":"traceutil/trace.go:171","msg":"trace[1158840167] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"139.920393ms","start":"2026-08-07T04:29:23.137966Z","end":"2026-08-07T04:29:23.277887Z","steps":["trace[1158840167] 'process raft request' (duration: 137.283791ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:23.278174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.809761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-08-07T04:29:23.278223Z","caller":"traceutil/trace.go:171","msg":"trace[1371036211] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:512; }","duration":"139.889101ms","start":"2026-08-07T04:29:23.138322Z","end":"2026-08-07T04:29:23.278211Z","steps":["trace[1371036211] 'agreement among raft nodes before linearized reading' (duration: 139.720649ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:25.97899Z","caller":"traceutil/trace.go:171","msg":"trace[355834288] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"884.519548ms","start":"2026-08-07T04:29:25.094442Z","end":"2026-08-07T04:29:25.978962Z","steps":["trace[355834288] 'process raft request' (duration: 884.394586ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:25.97915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.094423Z","time spent":"884.65489ms","remote":"127.0.0.1:53736","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-07T04:29:25.991117Z","caller":"traceutil/trace.go:171","msg":"trace[710277125] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"891.578108ms","start":"2026-08-07T04:29:25.099516Z","end":"2026-08-07T04:29:25.991094Z","steps":["trace[710277125] 'process raft request' (duration: 891.247053ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:25.991143Z","caller":"traceutil/trace.go:171","msg":"trace[2010851630] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"888.182504ms","start":"2026-08-07T04:29:25.102946Z","end":"2026-08-07T04:29:25.991129Z","steps":["trace[2010851630] 'process raft request' (duration: 888.081203ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:25.991223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.099494Z","time spent":"891.68871ms","remote":"127.0.0.1:53736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:29:25.991237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.102929Z","time spent":"888.277546ms","remote":"127.0.0.1:53736","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-07T04:29:25.991294Z","caller":"traceutil/trace.go:171","msg":"trace[526821329] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"879.216025ms","start":"2026-08-07T04:29:25.112043Z","end":"2026-08-07T04:29:25.991259Z","steps":["trace[526821329] 'process raft request' (duration: 879.027882ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:25.991397Z","caller":"traceutil/trace.go:171","msg":"trace[1286975266] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"877.59246ms","start":"2026-08-07T04:29:25.11379Z","end":"2026-08-07T04:29:25.991383Z","steps":["trace[1286975266] 'process raft request' (duration: 877.400807ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:25.991429Z","caller":"traceutil/trace.go:171","msg":"trace[1918134441] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"876.406391ms","start":"2026-08-07T04:29:25.115013Z","end":"2026-08-07T04:29:25.99142Z","steps":["trace[1918134441] 'process raft request' (duration: 876.274539ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:25.991506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.115004Z","time spent":"876.482952ms","remote":"127.0.0.1:53736","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-07T04:29:25.991549Z","caller":"traceutil/trace.go:171","msg":"trace[1982549872] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"865.595112ms","start":"2026-08-07T04:29:25.125851Z","end":"2026-08-07T04:29:25.991446Z","steps":["trace[1982549872] 'process raft request' (duration: 865.48538ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:25.991592Z","caller":"traceutil/trace.go:171","msg":"trace[803741618] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"862.20176ms","start":"2026-08-07T04:29:25.129377Z","end":"2026-08-07T04:29:25.991579Z","steps":["trace[803741618] 'process raft request' (duration: 862.024327ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:25.991417Z","caller":"traceutil/trace.go:171","msg":"trace[314434199] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"879.203725ms","start":"2026-08-07T04:29:25.112091Z","end":"2026-08-07T04:29:25.991295Z","steps":["trace[314434199] 'process raft request' (duration: 879.021652ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:25.991645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.129367Z","time spent":"862.25309ms","remote":"127.0.0.1:53736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:29:25.991673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.125842Z","time spent":"865.779574ms","remote":"127.0.0.1:53736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:29:25.991706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.112087Z","time spent":"879.57488ms","remote":"127.0.0.1:53736","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-07T04:29:25.991746Z","caller":"traceutil/trace.go:171","msg":"trace[470264546] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"706.719131ms","start":"2026-08-07T04:29:25.285017Z","end":"2026-08-07T04:29:25.991736Z","steps":["trace[470264546] 'process raft request' (duration: 706.543969ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:25.991762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.950479ms","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-07T04:29:25.991435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.112031Z","time spent":"879.342457ms","remote":"127.0.0.1:53736","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-07T04:29:25.991784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.284983Z","time spent":"706.783623ms","remote":"127.0.0.1:53736","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-07T04:29:25.991804Z","caller":"traceutil/trace.go:171","msg":"trace[1423549084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:559; }","duration":"287.033841ms","start":"2026-08-07T04:29:25.70476Z","end":"2026-08-07T04:29:25.991794Z","steps":["trace[1423549084] 'agreement among raft nodes before linearized reading' (duration: 286.889929ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:25.991446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.113782Z","time spent":"877.644231ms","remote":"127.0.0.1:53736","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-07T04:29:25.99182Z","caller":"traceutil/trace.go:171","msg":"trace[458874374] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"856.465989ms","start":"2026-08-07T04:29:25.13534Z","end":"2026-08-07T04:29:25.991806Z","steps":["trace[458874374] 'process raft request' (duration: 856.109654ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:25.991707Z","caller":"traceutil/trace.go:171","msg":"trace[16567958] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"840.464969ms","start":"2026-08-07T04:29:25.151226Z","end":"2026-08-07T04:29:25.991691Z","steps":["trace[16567958] 'process raft request' (duration: 840.274297ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:25.991878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.135318Z","time spent":"856.53279ms","remote":"127.0.0.1:53736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:29:25.991986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:25.151205Z","time spent":"840.695774ms","remote":"127.0.0.1:53736","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-07T04:29:25.991629Z","caller":"traceutil/trace.go:171","msg":"trace[2114998846] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:574; }","duration":"286.806467ms","start":"2026-08-07T04:29:25.70481Z","end":"2026-08-07T04:29:25.991616Z","steps":["trace[2114998846] 'read index received' (duration: 274.15158ms)","trace[2114998846] 'applied index is now lower than readState.Index' (duration: 12.653947ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:29:25.993445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.391703ms","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-07T04:29:25.993493Z","caller":"traceutil/trace.go:171","msg":"trace[1312643944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:561; }","duration":"208.472504ms","start":"2026-08-07T04:29:25.785009Z","end":"2026-08-07T04:29:25.993482Z","steps":["trace[1312643944] 'agreement among raft nodes before linearized reading' (duration: 208.356342ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:29.190221Z","caller":"traceutil/trace.go:171","msg":"trace[218315760] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"168.435806ms","start":"2026-08-07T04:29:29.021762Z","end":"2026-08-07T04:29:29.190198Z","steps":["trace[218315760] 'read index received' (duration: 167.923458ms)","trace[218315760] 'applied index is now lower than readState.Index' (duration: 511.868µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:29.190247Z","caller":"traceutil/trace.go:171","msg":"trace[1181199085] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"190.057646ms","start":"2026-08-07T04:29:29.000178Z","end":"2026-08-07T04:29:29.190235Z","steps":["trace[1181199085] 'process raft request' (duration: 189.736071ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:29.190397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.624199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:29:29.190428Z","caller":"traceutil/trace.go:171","msg":"trace[1059627050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"168.6673ms","start":"2026-08-07T04:29:29.021752Z","end":"2026-08-07T04:29:29.190419Z","steps":["trace[1059627050] 'agreement among raft nodes before linearized reading' (duration: 168.585078ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:32.734626Z","caller":"traceutil/trace.go:171","msg":"trace[1407846697] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"438.980159ms","start":"2026-08-07T04:29:32.295615Z","end":"2026-08-07T04:29:32.734595Z","steps":["trace[1407846697] 'read index received' (duration: 438.054566ms)","trace[1407846697] 'applied index is now lower than readState.Index' (duration: 924.453µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:32.734747Z","caller":"traceutil/trace.go:171","msg":"trace[2104845714] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"561.885249ms","start":"2026-08-07T04:29:32.172824Z","end":"2026-08-07T04:29:32.734709Z","steps":["trace[2104845714] 'process raft request' (duration: 561.191379ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:32.734911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.263394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-d8xrf\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-07T04:29:32.734921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:32.172796Z","time spent":"562.033262ms","remote":"127.0.0.1:53772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:29:32.734968Z","caller":"traceutil/trace.go:171","msg":"trace[1093631690] range","detail":"{range_begin:/registry/pods/kube-system/cilium-d8xrf; range_end:; response_count:1; response_revision:656; }","duration":"439.389546ms","start":"2026-08-07T04:29:32.295563Z","end":"2026-08-07T04:29:32.734953Z","steps":["trace[1093631690] 'agreement among raft nodes before linearized reading' (duration: 439.177742ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:32.735024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:32.295545Z","time spent":"439.458887ms","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-d8xrf\" "} {"level":"warn","ts":"2026-08-07T04:29:33.29667Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830514158953848,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-07T04:29:33.451966Z","caller":"traceutil/trace.go:171","msg":"trace[503128776] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"701.990469ms","start":"2026-08-07T04:29:32.749949Z","end":"2026-08-07T04:29:33.451939Z","steps":["trace[503128776] 'process raft request' (duration: 701.851956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:33.452087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:32.749929Z","time spent":"702.09442ms","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:29:34.470631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.960668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-07T04:29:34.470806Z","caller":"traceutil/trace.go:171","msg":"trace[1646362835] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:686; }","duration":"1.674979683s","start":"2026-08-07T04:29:32.795804Z","end":"2026-08-07T04:29:34.470783Z","steps":["trace[1646362835] 'read index received' (duration: 655.991059ms)","trace[1646362835] 'applied index is now lower than readState.Index' (duration: 1.018986724s)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:34.470924Z","caller":"traceutil/trace.go:171","msg":"trace[1666207268] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"1.675324628s","start":"2026-08-07T04:29:32.795559Z","end":"2026-08-07T04:29:34.470884Z","steps":["trace[1666207268] 'process raft request' (duration: 940.001165ms)","trace[1666207268] 'compare' (duration: 734.647474ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:29:34.471086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:32.795531Z","time spent":"1.67547074s","remote":"127.0.0.1:54204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-07T04:29:34.47112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.675310767s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-07T04:29:34.471158Z","caller":"traceutil/trace.go:171","msg":"trace[2080919438] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:658; }","duration":"1.6753947s","start":"2026-08-07T04:29:32.79575Z","end":"2026-08-07T04:29:34.471144Z","steps":["trace[2080919438] 'agreement among raft nodes before linearized reading' (duration: 1.675154635s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:34.471197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:32.795729Z","time spent":"1.6754589s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-07T04:29:34.471311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.523811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-08-07T04:29:34.471314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.845195ms","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-07T04:29:34.471391Z","caller":"traceutil/trace.go:171","msg":"trace[426324803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:658; }","duration":"428.656112ms","start":"2026-08-07T04:29:34.042716Z","end":"2026-08-07T04:29:34.471372Z","steps":["trace[426324803] 'agreement among raft nodes before linearized reading' (duration: 428.409059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:34.471386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.306533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:29:34.471407Z","caller":"traceutil/trace.go:171","msg":"trace[461337343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:658; }","duration":"432.963007ms","start":"2026-08-07T04:29:34.038418Z","end":"2026-08-07T04:29:34.471381Z","steps":["trace[461337343] 'agreement among raft nodes before linearized reading' (duration: 432.661402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:34.471444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:34.04269Z","time spent":"428.745394ms","remote":"127.0.0.1:53952","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-07T04:29:34.47145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:34.038407Z","time spent":"433.034048ms","remote":"127.0.0.1:53952","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-07T04:29:34.471452Z","caller":"traceutil/trace.go:171","msg":"trace[259975298] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"450.404914ms","start":"2026-08-07T04:29:34.021029Z","end":"2026-08-07T04:29:34.471434Z","steps":["trace[259975298] 'agreement among raft nodes before linearized reading' (duration: 450.286692ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:34.471437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.552993227s","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-07T04:29:34.471488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:34.021009Z","time spent":"450.473876ms","remote":"127.0.0.1:53662","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-07T04:29:34.471514Z","caller":"traceutil/trace.go:171","msg":"trace[801207827] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:658; }","duration":"1.553117209s","start":"2026-08-07T04:29:32.918376Z","end":"2026-08-07T04:29:34.471493Z","steps":["trace[801207827] 'agreement among raft nodes before linearized reading' (duration: 1.552705522s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:34.471507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.427027135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-07T04:29:34.471562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:32.91836Z","time spent":"1.553192621s","remote":"127.0.0.1:53952","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-07T04:29:34.471593Z","caller":"traceutil/trace.go:171","msg":"trace[1144293548] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:658; }","duration":"1.427167108s","start":"2026-08-07T04:29:33.044404Z","end":"2026-08-07T04:29:34.471571Z","steps":["trace[1144293548] 'agreement among raft nodes before linearized reading' (duration: 1.426985455s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:34.47164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:33.044384Z","time spent":"1.427246419s","remote":"127.0.0.1:53724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"warn","ts":"2026-08-07T04:29:36.95853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.034074713s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:29:36.958699Z","caller":"traceutil/trace.go:171","msg":"trace[288188988] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:658; }","duration":"2.034247786s","start":"2026-08-07T04:29:34.924425Z","end":"2026-08-07T04:29:36.958673Z","steps":["trace[288188988] 'range keys from in-memory index tree' (duration: 2.034057353s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:36.958887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.378574301s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-07T04:29:36.959271Z","caller":"traceutil/trace.go:171","msg":"trace[1188754057] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"2.483102627s","start":"2026-08-07T04:29:34.476134Z","end":"2026-08-07T04:29:36.959237Z","steps":["trace[1188754057] 'process raft request' (duration: 104.07518ms)","trace[1188754057] 'compare' (duration: 2.378197335s)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:29:36.959448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:34.47611Z","time spent":"2.483249699s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:29:36.959837Z","caller":"traceutil/trace.go:171","msg":"trace[1205563408] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"2.483327781s","start":"2026-08-07T04:29:34.476492Z","end":"2026-08-07T04:29:36.959819Z","steps":["trace[1205563408] 'process raft request' (duration: 2.483093727s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:36.959927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:34.476482Z","time spent":"2.483402701s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:29:36.959969Z","caller":"traceutil/trace.go:171","msg":"trace[165798043] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"2.483456412s","start":"2026-08-07T04:29:34.476487Z","end":"2026-08-07T04:29:36.959943Z","steps":["trace[165798043] 'process raft request' (duration: 2.482955525s)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:36.959988Z","caller":"traceutil/trace.go:171","msg":"trace[794364062] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"2.483234498s","start":"2026-08-07T04:29:34.476724Z","end":"2026-08-07T04:29:36.959958Z","steps":["trace[794364062] 'process raft request' (duration: 2.482894744s)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:36.959998Z","caller":"traceutil/trace.go:171","msg":"trace[2119536805] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:688; }","duration":"2.478520999s","start":"2026-08-07T04:29:34.481456Z","end":"2026-08-07T04:29:36.959977Z","steps":["trace[2119536805] 'read index received' (duration: 20.204869ms)","trace[2119536805] 'applied index is now lower than readState.Index' (duration: 2.45831458s)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:29:36.960054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:34.476468Z","time spent":"2.483540613s","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:29:36.960066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:34.476667Z","time spent":"2.483357681s","remote":"127.0.0.1:53952","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-07T04:29:36.960134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.478652391s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:29:36.96016Z","caller":"traceutil/trace.go:171","msg":"trace[86561447] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:663; }","duration":"2.478724322s","start":"2026-08-07T04:29:34.481429Z","end":"2026-08-07T04:29:36.960153Z","steps":["trace[86561447] 'agreement among raft nodes before linearized reading' (duration: 2.478652001s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:36.960183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:34.481417Z","time spent":"2.478761083s","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-08-07T04:29:36.960292Z","caller":"traceutil/trace.go:171","msg":"trace[215080369] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"2.457324585s","start":"2026-08-07T04:29:34.502942Z","end":"2026-08-07T04:29:36.960266Z","steps":["trace[215080369] 'process raft request' (duration: 2.456715476s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:36.960425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:34.50292Z","time spent":"2.457430537s","remote":"127.0.0.1:53724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:29:36.960446Z","caller":"traceutil/trace.go:171","msg":"trace[129563118] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"223.297686ms","start":"2026-08-07T04:29:36.737135Z","end":"2026-08-07T04:29:36.960433Z","steps":["trace[129563118] 'process raft request' (duration: 222.559236ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:36.960475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.938253847s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-07T04:29:36.960624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.491288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:29:36.960664Z","caller":"traceutil/trace.go:171","msg":"trace[437280265] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:664; }","duration":"419.571908ms","start":"2026-08-07T04:29:36.541081Z","end":"2026-08-07T04:29:36.960653Z","steps":["trace[437280265] 'agreement among raft nodes before linearized reading' (duration: 419.513177ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:36.960694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:36.541046Z","time spent":"419.6407ms","remote":"127.0.0.1:53914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-08-07T04:29:36.960514Z","caller":"traceutil/trace.go:171","msg":"trace[997804207] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:664; }","duration":"1.938333408s","start":"2026-08-07T04:29:35.022169Z","end":"2026-08-07T04:29:36.960503Z","steps":["trace[997804207] 'agreement among raft nodes before linearized reading' (duration: 1.938242537s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:36.960824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:35.022145Z","time spent":"1.938666253s","remote":"127.0.0.1:53662","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-07T04:29:38.535569Z","caller":"traceutil/trace.go:171","msg":"trace[294951081] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"204.237656ms","start":"2026-08-07T04:29:38.331238Z","end":"2026-08-07T04:29:38.535476Z","steps":["trace[294951081] 'process raft request' (duration: 202.836345ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:39.186037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.964145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-07T04:29:39.186088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.860651ms","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-07T04:29:39.186122Z","caller":"traceutil/trace.go:171","msg":"trace[2130088936] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:680; }","duration":"226.113837ms","start":"2026-08-07T04:29:38.95999Z","end":"2026-08-07T04:29:39.186104Z","steps":["trace[2130088936] 'count revisions from in-memory index tree' (duration: 225.872644ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:39.186136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.471885ms","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-07T04:29:39.186158Z","caller":"traceutil/trace.go:171","msg":"trace[1125760868] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:680; }","duration":"220.975603ms","start":"2026-08-07T04:29:38.965164Z","end":"2026-08-07T04:29:39.186139Z","steps":["trace[1125760868] 'range keys from in-memory index tree' (duration: 220.69738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:39.186172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.77137ms","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-07T04:29:39.186188Z","caller":"traceutil/trace.go:171","msg":"trace[2130702186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:680; }","duration":"220.538176ms","start":"2026-08-07T04:29:38.965636Z","end":"2026-08-07T04:29:39.186174Z","steps":["trace[2130702186] 'range keys from in-memory index tree' (duration: 220.325613ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:39.1862Z","caller":"traceutil/trace.go:171","msg":"trace[1919680306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:680; }","duration":"220.830541ms","start":"2026-08-07T04:29:38.96536Z","end":"2026-08-07T04:29:39.186191Z","steps":["trace[1919680306] 'range keys from in-memory index tree' (duration: 220.692489ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:39.186789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.538796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-07T04:29:39.186863Z","caller":"traceutil/trace.go:171","msg":"trace[2138588191] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:680; }","duration":"222.646667ms","start":"2026-08-07T04:29:38.9642Z","end":"2026-08-07T04:29:39.186846Z","steps":["trace[2138588191] 'range keys from in-memory index tree' (duration: 221.795414ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:39.676203Z","caller":"traceutil/trace.go:171","msg":"trace[2098647362] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"176.399759ms","start":"2026-08-07T04:29:39.499775Z","end":"2026-08-07T04:29:39.676175Z","steps":["trace[2098647362] 'process raft request' (duration: 144.781093ms)","trace[2098647362] 'compare' (duration: 31.510175ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:39.88741Z","caller":"traceutil/trace.go:171","msg":"trace[141967639] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"205.871363ms","start":"2026-08-07T04:29:39.681515Z","end":"2026-08-07T04:29:39.887387Z","steps":["trace[141967639] 'process raft request' (duration: 202.826689ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:39.887584Z","caller":"traceutil/trace.go:171","msg":"trace[1486918781] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"205.955094ms","start":"2026-08-07T04:29:39.681606Z","end":"2026-08-07T04:29:39.887561Z","steps":["trace[1486918781] 'process raft request' (duration: 205.731211ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:39.894056Z","caller":"traceutil/trace.go:171","msg":"trace[1200774064] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"151.087165ms","start":"2026-08-07T04:29:39.742937Z","end":"2026-08-07T04:29:39.894024Z","steps":["trace[1200774064] 'process raft request' (duration: 150.934502ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:41.596318Z","caller":"traceutil/trace.go:171","msg":"trace[1954735525] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"102.503829ms","start":"2026-08-07T04:29:41.493786Z","end":"2026-08-07T04:29:41.59629Z","steps":["trace[1954735525] 'process raft request' (duration: 100.464351ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:45.792449Z","caller":"traceutil/trace.go:171","msg":"trace[134699553] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"182.954431ms","start":"2026-08-07T04:29:45.60947Z","end":"2026-08-07T04:29:45.792424Z","steps":["trace[134699553] 'read index received' (duration: 181.237977ms)","trace[134699553] 'applied index is now lower than readState.Index' (duration: 1.715494ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:45.792481Z","caller":"traceutil/trace.go:171","msg":"trace[196916476] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"212.36456ms","start":"2026-08-07T04:29:45.580092Z","end":"2026-08-07T04:29:45.792456Z","steps":["trace[196916476] 'process raft request' (duration: 210.628936ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:45.792651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.173934ms","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-07T04:29:45.792714Z","caller":"traceutil/trace.go:171","msg":"trace[1234543433] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:774; }","duration":"183.253955ms","start":"2026-08-07T04:29:45.609452Z","end":"2026-08-07T04:29:45.792706Z","steps":["trace[1234543433] 'agreement among raft nodes before linearized reading' (duration: 183.095803ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:46.475806Z","caller":"traceutil/trace.go:171","msg":"trace[231783845] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:811; }","duration":"122.514989ms","start":"2026-08-07T04:29:46.353267Z","end":"2026-08-07T04:29:46.475782Z","steps":["trace[231783845] 'read index received' (duration: 122.423428ms)","trace[231783845] 'applied index is now lower than readState.Index' (duration: 90.081µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:46.475878Z","caller":"traceutil/trace.go:171","msg":"trace[1632463465] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"127.294147ms","start":"2026-08-07T04:29:46.348547Z","end":"2026-08-07T04:29:46.475842Z","steps":["trace[1632463465] 'process raft request' (duration: 127.109443ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:46.475957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.665492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:29:46.475998Z","caller":"traceutil/trace.go:171","msg":"trace[1612704695] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:777; }","duration":"122.754414ms","start":"2026-08-07T04:29:46.353233Z","end":"2026-08-07T04:29:46.475987Z","steps":["trace[1612704695] 'agreement among raft nodes before linearized reading' (duration: 122.671893ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:46.476095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.448349ms","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-07T04:29:46.476221Z","caller":"traceutil/trace.go:171","msg":"trace[1710423312] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:777; }","duration":"122.601071ms","start":"2026-08-07T04:29:46.353577Z","end":"2026-08-07T04:29:46.476178Z","steps":["trace[1710423312] 'agreement among raft nodes before linearized reading' (duration: 122.395639ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:46.476348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.587681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:29:46.476413Z","caller":"traceutil/trace.go:171","msg":"trace[1307028611] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:777; }","duration":"122.678602ms","start":"2026-08-07T04:29:46.35372Z","end":"2026-08-07T04:29:46.476398Z","steps":["trace[1307028611] 'agreement among raft nodes before linearized reading' (duration: 122.400268ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:47.556266Z","caller":"traceutil/trace.go:171","msg":"trace[1968385860] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"282.347628ms","start":"2026-08-07T04:29:47.273884Z","end":"2026-08-07T04:29:47.556231Z","steps":["trace[1968385860] 'process raft request' (duration: 224.55815ms)","trace[1968385860] 'compare' (duration: 57.634476ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:47.593681Z","caller":"traceutil/trace.go:171","msg":"trace[948108308] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"319.40202ms","start":"2026-08-07T04:29:47.27425Z","end":"2026-08-07T04:29:47.593652Z","steps":["trace[948108308] 'process raft request' (duration: 319.275138ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:47.593702Z","caller":"traceutil/trace.go:171","msg":"trace[84419719] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"319.500931ms","start":"2026-08-07T04:29:47.274171Z","end":"2026-08-07T04:29:47.593672Z","steps":["trace[84419719] 'process raft request' (duration: 319.219287ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:47.593861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:47.274161Z","time spent":"319.617572ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T04:29:47.593935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:47.274228Z","time spent":"319.535111ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:29:47.593932Z","caller":"traceutil/trace.go:171","msg":"trace[989612677] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"210.608437ms","start":"2026-08-07T04:29:47.383294Z","end":"2026-08-07T04:29:47.593902Z","steps":["trace[989612677] 'process raft request' (duration: 210.311553ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:47.722394Z","caller":"traceutil/trace.go:171","msg":"trace[1143289056] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"193.538482ms","start":"2026-08-07T04:29:47.52883Z","end":"2026-08-07T04:29:47.722369Z","steps":["trace[1143289056] 'process raft request' (duration: 193.482651ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:47.722711Z","caller":"traceutil/trace.go:171","msg":"trace[131145039] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"196.071927ms","start":"2026-08-07T04:29:47.526561Z","end":"2026-08-07T04:29:47.722633Z","steps":["trace[131145039] 'process raft request' (duration: 140.940896ms)","trace[131145039] 'compare' (duration: 54.673455ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:48.133681Z","caller":"traceutil/trace.go:171","msg":"trace[952489087] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"248.181818ms","start":"2026-08-07T04:29:47.885466Z","end":"2026-08-07T04:29:48.133647Z","steps":["trace[952489087] 'process raft request' (duration: 173.991109ms)","trace[952489087] 'compare' (duration: 73.752213ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:48.149203Z","caller":"traceutil/trace.go:171","msg":"trace[1005484192] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"225.597865ms","start":"2026-08-07T04:29:47.923582Z","end":"2026-08-07T04:29:48.14918Z","steps":["trace[1005484192] 'process raft request' (duration: 225.436032ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:48.149312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.709604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:29:48.149356Z","caller":"traceutil/trace.go:171","msg":"trace[1519900283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"127.801316ms","start":"2026-08-07T04:29:48.021543Z","end":"2026-08-07T04:29:48.149344Z","steps":["trace[1519900283] 'agreement among raft nodes before linearized reading' (duration: 127.718145ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:48.149418Z","caller":"traceutil/trace.go:171","msg":"trace[1793838858] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:827; }","duration":"127.548942ms","start":"2026-08-07T04:29:48.021593Z","end":"2026-08-07T04:29:48.149142Z","steps":["trace[1793838858] 'read index received' (duration: 37.945041ms)","trace[1793838858] 'applied index is now lower than readState.Index' (duration: 89.603001ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:29:49.990627Z","caller":"traceutil/trace.go:171","msg":"trace[1223872666] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"126.50533ms","start":"2026-08-07T04:29:49.864095Z","end":"2026-08-07T04:29:49.9906Z","steps":["trace[1223872666] 'process raft request' (duration: 126.316818ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:54.509925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.785629ms","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-07T04:29:54.510319Z","caller":"traceutil/trace.go:171","msg":"trace[184296166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:825; }","duration":"892.195795ms","start":"2026-08-07T04:29:53.618103Z","end":"2026-08-07T04:29:54.510299Z","steps":["trace[184296166] 'range keys from in-memory index tree' (duration: 891.616358ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:54.510367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:53.618047Z","time spent":"892.306746ms","remote":"127.0.0.1:53952","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-07T04:29:54.509996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.177197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-07T04:29:54.510425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.091325406s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-d2v4l\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-07T04:29:54.510979Z","caller":"traceutil/trace.go:171","msg":"trace[1231859040] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-d2v4l; range_end:; response_count:1; response_revision:825; }","duration":"1.092031766s","start":"2026-08-07T04:29:53.418926Z","end":"2026-08-07T04:29:54.510958Z","steps":["trace[1231859040] 'range keys from in-memory index tree' (duration: 1.091236596s)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:29:54.51043Z","caller":"traceutil/trace.go:171","msg":"trace[1845015151] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:825; }","duration":"497.665173ms","start":"2026-08-07T04:29:54.012744Z","end":"2026-08-07T04:29:54.510409Z","steps":["trace[1845015151] 'range keys from in-memory index tree' (duration: 496.999105ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:54.511106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:54.012716Z","time spent":"498.371053ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-07T04:29:54.510178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.822576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-07T04:29:54.51112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:53.418908Z","time spent":"1.092195418s","remote":"127.0.0.1:53848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-d2v4l\" "} {"level":"info","ts":"2026-08-07T04:29:54.511211Z","caller":"traceutil/trace.go:171","msg":"trace[983377490] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:825; }","duration":"879.885601ms","start":"2026-08-07T04:29:53.631302Z","end":"2026-08-07T04:29:54.511187Z","steps":["trace[983377490] 'count revisions from in-memory index tree' (duration: 878.770476ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:54.510183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.218519312s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-07T04:29:54.511889Z","caller":"traceutil/trace.go:171","msg":"trace[861300099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:825; }","duration":"1.220263355s","start":"2026-08-07T04:29:53.291599Z","end":"2026-08-07T04:29:54.511862Z","steps":["trace[861300099] 'range keys from in-memory index tree' (duration: 1.21836163s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:54.511957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:53.291577Z","time spent":"1.220361266s","remote":"127.0.0.1:53952","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-07T04:29:54.510244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.818624ms","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-07T04:29:54.512146Z","caller":"traceutil/trace.go:171","msg":"trace[1486154722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:825; }","duration":"935.751249ms","start":"2026-08-07T04:29:53.576374Z","end":"2026-08-07T04:29:54.512125Z","steps":["trace[1486154722] 'range keys from in-memory index tree' (duration: 933.674152ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:54.512187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:53.576334Z","time spent":"935.84244ms","remote":"127.0.0.1:53952","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-07T04:29:54.510246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.832977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-07T04:29:54.512356Z","caller":"traceutil/trace.go:171","msg":"trace[1929428838] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:825; }","duration":"889.969215ms","start":"2026-08-07T04:29:53.622376Z","end":"2026-08-07T04:29:54.512345Z","steps":["trace[1929428838] 'range keys from in-memory index tree' (duration: 887.712916ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:54.512395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:53.62237Z","time spent":"890.015565ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-07T04:29:54.510078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.465555716s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-07T04:29:54.51258Z","caller":"traceutil/trace.go:171","msg":"trace[341303341] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:825; }","duration":"1.468087879s","start":"2026-08-07T04:29:53.044483Z","end":"2026-08-07T04:29:54.512571Z","steps":["trace[341303341] 'range keys from in-memory index tree' (duration: 1.465454724s)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:29:54.512612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:53.044467Z","time spent":"1.46813652s","remote":"127.0.0.1:53724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"warn","ts":"2026-08-07T04:29:54.511277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:29:53.631291Z","time spent":"879.965942ms","remote":"127.0.0.1:54142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-08-07T04:30:01.829495Z","caller":"traceutil/trace.go:171","msg":"trace[297012837] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"135.134389ms","start":"2026-08-07T04:30:01.694332Z","end":"2026-08-07T04:30:01.829467Z","steps":["trace[297012837] 'process raft request' (duration: 134.961467ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:30:04.921729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.8467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:30:04.921945Z","caller":"traceutil/trace.go:171","msg":"trace[1166840975] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:947; }","duration":"162.092073ms","start":"2026-08-07T04:30:04.759828Z","end":"2026-08-07T04:30:04.92192Z","steps":["trace[1166840975] 'range keys from in-memory index tree' (duration: 161.752468ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:30:08.741937Z","caller":"traceutil/trace.go:171","msg":"trace[1476751870] linearizableReadLoop","detail":"{readStateIndex:1023; appliedIndex:1022; }","duration":"128.679958ms","start":"2026-08-07T04:30:08.613236Z","end":"2026-08-07T04:30:08.741916Z","steps":["trace[1476751870] 'read index received' (duration: 128.473645ms)","trace[1476751870] 'applied index is now lower than readState.Index' (duration: 205.223µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:30:08.742036Z","caller":"traceutil/trace.go:171","msg":"trace[1404062986] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"136.415727ms","start":"2026-08-07T04:30:08.60559Z","end":"2026-08-07T04:30:08.742006Z","steps":["trace[1404062986] 'process raft request' (duration: 136.205733ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:30:08.74213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.873401ms","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-07T04:30:08.742163Z","caller":"traceutil/trace.go:171","msg":"trace[1932225123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:984; }","duration":"128.939611ms","start":"2026-08-07T04:30:08.613215Z","end":"2026-08-07T04:30:08.742154Z","steps":["trace[1932225123] 'agreement among raft nodes before linearized reading' (duration: 128.80894ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:30:08.742423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.425081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-07T04:30:08.742551Z","caller":"traceutil/trace.go:171","msg":"trace[678203904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:984; }","duration":"122.630103ms","start":"2026-08-07T04:30:08.619886Z","end":"2026-08-07T04:30:08.742516Z","steps":["trace[678203904] 'agreement among raft nodes before linearized reading' (duration: 122.227718ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:31:01.361306Z","caller":"traceutil/trace.go:171","msg":"trace[2060189452] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1228; }","duration":"278.172725ms","start":"2026-08-07T04:31:01.083113Z","end":"2026-08-07T04:31:01.361286Z","steps":["trace[2060189452] 'read index received' (duration: 278.003914ms)","trace[2060189452] 'applied index is now lower than readState.Index' (duration: 167.991µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:31:01.361344Z","caller":"traceutil/trace.go:171","msg":"trace[1533492164] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"300.84047ms","start":"2026-08-07T04:31:01.060481Z","end":"2026-08-07T04:31:01.361321Z","steps":["trace[1533492164] 'process raft request' (duration: 300.670338ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:01.361489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.285127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-07T04:31:01.361515Z","caller":"traceutil/trace.go:171","msg":"trace[1535751678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1177; }","duration":"278.324248ms","start":"2026-08-07T04:31:01.083182Z","end":"2026-08-07T04:31:01.361507Z","steps":["trace[1535751678] 'agreement among raft nodes before linearized reading' (duration: 278.213206ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:01.361508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.378718ms","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-07T04:31:01.361566Z","caller":"traceutil/trace.go:171","msg":"trace[1677455959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1177; }","duration":"278.477499ms","start":"2026-08-07T04:31:01.083073Z","end":"2026-08-07T04:31:01.361551Z","steps":["trace[1677455959] 'agreement among raft nodes before linearized reading' (duration: 278.316416ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:01.361558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:31:01.060468Z","time spent":"300.945192ms","remote":"127.0.0.1:53952","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-07T04:31:29.6572Z","caller":"traceutil/trace.go:171","msg":"trace[1086396794] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"112.853955ms","start":"2026-08-07T04:31:29.544304Z","end":"2026-08-07T04:31:29.657158Z","steps":["trace[1086396794] 'process raft request' (duration: 49.292409ms)","trace[1086396794] 'compare' (duration: 63.409165ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:31:29.657412Z","caller":"traceutil/trace.go:171","msg":"trace[37932286] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"111.215667ms","start":"2026-08-07T04:31:29.546161Z","end":"2026-08-07T04:31:29.657377Z","steps":["trace[37932286] 'process raft request' (duration: 110.958935ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:44.52331Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830514158955532,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-07T04:31:44.591766Z","caller":"traceutil/trace.go:171","msg":"trace[1164698007] linearizableReadLoop","detail":"{readStateIndex:1420; appliedIndex:1419; }","duration":"568.999769ms","start":"2026-08-07T04:31:44.022739Z","end":"2026-08-07T04:31:44.591739Z","steps":["trace[1164698007] 'read index received' (duration: 568.791986ms)","trace[1164698007] 'applied index is now lower than readState.Index' (duration: 206.843µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:31:44.591824Z","caller":"traceutil/trace.go:171","msg":"trace[2096022027] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"593.85776ms","start":"2026-08-07T04:31:43.997927Z","end":"2026-08-07T04:31:44.591785Z","steps":["trace[2096022027] 'process raft request' (duration: 593.655238ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:44.59194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.18816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-07T04:31:44.591985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:31:43.997893Z","time spent":"593.998122ms","remote":"127.0.0.1:53952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T04:31:44.592032Z","caller":"traceutil/trace.go:171","msg":"trace[468507532] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1357; }","duration":"569.308621ms","start":"2026-08-07T04:31:44.02269Z","end":"2026-08-07T04:31:44.591999Z","steps":["trace[468507532] 'agreement among raft nodes before linearized reading' (duration: 569.15137ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:44.592082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T04:31:44.022671Z","time spent":"569.399972ms","remote":"127.0.0.1:53662","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-07T04:31:45.371847Z","caller":"traceutil/trace.go:171","msg":"trace[1496527982] linearizableReadLoop","detail":"{readStateIndex:1421; appliedIndex:1420; }","duration":"113.900585ms","start":"2026-08-07T04:31:45.257917Z","end":"2026-08-07T04:31:45.371817Z","steps":["trace[1496527982] 'read index received' (duration: 113.620812ms)","trace[1496527982] 'applied index is now lower than readState.Index' (duration: 278.483µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:31:45.371969Z","caller":"traceutil/trace.go:171","msg":"trace[1930012451] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"217.090069ms","start":"2026-08-07T04:31:45.154838Z","end":"2026-08-07T04:31:45.371928Z","steps":["trace[1930012451] 'process raft request' (duration: 216.753275ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:45.372093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.151707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:31:45.37215Z","caller":"traceutil/trace.go:171","msg":"trace[1933111359] 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:1358; }","duration":"114.275038ms","start":"2026-08-07T04:31:45.257861Z","end":"2026-08-07T04:31:45.372136Z","steps":["trace[1933111359] 'agreement among raft nodes before linearized reading' (duration: 114.133386ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:45.372501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.888723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-07T04:31:45.372557Z","caller":"traceutil/trace.go:171","msg":"trace[489636378] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1358; }","duration":"109.967183ms","start":"2026-08-07T04:31:45.262575Z","end":"2026-08-07T04:31:45.372542Z","steps":["trace[489636378] 'agreement among raft nodes before linearized reading' (duration: 109.871232ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:45.82611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.748097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-07T04:31:45.826203Z","caller":"traceutil/trace.go:171","msg":"trace[1641760274] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1359; }","duration":"153.882279ms","start":"2026-08-07T04:31:45.672299Z","end":"2026-08-07T04:31:45.826182Z","steps":["trace[1641760274] 'range keys from in-memory index tree' (duration: 153.602886ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:31:46.035334Z","caller":"traceutil/trace.go:171","msg":"trace[287170119] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"205.252519ms","start":"2026-08-07T04:31:45.830051Z","end":"2026-08-07T04:31:46.035304Z","steps":["trace[287170119] 'process raft request' (duration: 130.692133ms)","trace[287170119] 'compare' (duration: 74.330883ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:31:46.035356Z","caller":"traceutil/trace.go:171","msg":"trace[1268767196] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"204.973076ms","start":"2026-08-07T04:31:45.830362Z","end":"2026-08-07T04:31:46.035336Z","steps":["trace[1268767196] 'process raft request' (duration: 204.881915ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:31:48.722517Z","caller":"traceutil/trace.go:171","msg":"trace[1294796458] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"118.752669ms","start":"2026-08-07T04:31:48.603729Z","end":"2026-08-07T04:31:48.722482Z","steps":["trace[1294796458] 'process raft request' (duration: 118.520667ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:48.916835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.190412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-07T04:31:48.917105Z","caller":"traceutil/trace.go:171","msg":"trace[1292394928] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"223.574707ms","start":"2026-08-07T04:31:48.693493Z","end":"2026-08-07T04:31:48.917068Z","steps":["trace[1292394928] 'process raft request' (duration: 120.073812ms)","trace[1292394928] 'compare' (duration: 103.078781ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T04:31:49.165318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.717947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"} {"level":"info","ts":"2026-08-07T04:31:49.165428Z","caller":"traceutil/trace.go:171","msg":"trace[141527791] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1374; }","duration":"121.861249ms","start":"2026-08-07T04:31:49.04354Z","end":"2026-08-07T04:31:49.165402Z","steps":["trace[141527791] 'range keys from in-memory index tree' (duration: 121.538646ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:31:49.165504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.023572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T04:31:49.165564Z","caller":"traceutil/trace.go:171","msg":"trace[1937139760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1374; }","duration":"145.125632ms","start":"2026-08-07T04:31:49.020424Z","end":"2026-08-07T04:31:49.165549Z","steps":["trace[1937139760] 'range keys from in-memory index tree' (duration: 144.505667ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T04:32:17.08027Z","caller":"traceutil/trace.go:171","msg":"trace[1606143041] linearizableReadLoop","detail":"{readStateIndex:1537; appliedIndex:1536; }","duration":"157.403855ms","start":"2026-08-07T04:32:16.922838Z","end":"2026-08-07T04:32:17.080242Z","steps":["trace[1606143041] 'read index received' (duration: 157.101224ms)","trace[1606143041] 'applied index is now lower than readState.Index' (duration: 301.461µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T04:32:17.080394Z","caller":"traceutil/trace.go:171","msg":"trace[1198186541] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"200.378959ms","start":"2026-08-07T04:32:16.879974Z","end":"2026-08-07T04:32:17.080353Z","steps":["trace[1198186541] 'process raft request' (duration: 200.09402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T04:32:17.080751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.830599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-d8xrf\" ","response":"range_response_count:1 size:18525"} {"level":"info","ts":"2026-08-07T04:32:17.080913Z","caller":"traceutil/trace.go:171","msg":"trace[1772347140] range","detail":"{range_begin:/registry/pods/kube-system/cilium-d8xrf; range_end:; response_count:1; response_revision:1467; }","duration":"158.105817ms","start":"2026-08-07T04:32:16.922776Z","end":"2026-08-07T04:32:17.080881Z","steps":["trace[1772347140] 'agreement among raft nodes before linearized reading' (duration: 157.618901ms)"],"step_count":1}