{"level":"warn","ts":"2026-08-20T16:52:57.850623Z","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-20T16:52:57.850722Z","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-20T16:52:57.850801Z","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-20T16:52:57.850817Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-08-20T16:52:57.850838Z","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-20T16:52:57.851659Z","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-20T16:52:57.851745Z","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-20T16:52:57.857247Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.246422ms"} {"level":"info","ts":"2026-08-20T16:52:57.866017Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-08-20T16:52:57.86611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-08-20T16:52:57.866134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-08-20T16:52:57.866157Z","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-20T16:52:57.866167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-08-20T16:52:57.866198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-08-20T16:52:57.875375Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-20T16:52:57.876981Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-20T16:52:57.878434Z","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-20T16:52:57.881212Z","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-20T16:52:57.882604Z","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-20T16:52:57.883501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-08-20T16:52:57.883618Z","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-20T16:52:57.882978Z","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-20T16:52:57.884067Z","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-20T16:52:57.884109Z","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-20T16:52:57.885952Z","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-20T16:52:57.886093Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-08-20T16:52:57.886241Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-08-20T16:52:57.886371Z","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-20T16:52:57.886405Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-20T16:52:58.467081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-08-20T16:52:58.467141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-08-20T16:52:58.467161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-08-20T16:52:58.467172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-08-20T16:52:58.467177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-08-20T16:52:58.467185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-08-20T16:52:58.467192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-08-20T16:52:58.470633Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T16:52:58.473016Z","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-20T16:52:58.473169Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T16:52:58.473206Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T16:52:58.473854Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-20T16:52:58.473945Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-20T16:52:58.475233Z","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-20T16:52:58.475631Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T16:52:58.475713Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T16:52:58.47743Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-08-20T16:52:58.477937Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-20T16:52:59.983011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.066879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-20T16:52:59.983235Z","caller":"traceutil/trace.go:171","msg":"trace[1396432058] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"178.374907ms","start":"2026-08-20T16:52:59.804837Z","end":"2026-08-20T16:52:59.983211Z","steps":["trace[1396432058] 'process raft request' (duration: 39.597007ms)","trace[1396432058] 'compare' (duration: 137.939324ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:00.017716Z","caller":"traceutil/trace.go:171","msg":"trace[438571610] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"212.278753ms","start":"2026-08-20T16:52:59.805399Z","end":"2026-08-20T16:53:00.017678Z","steps":["trace[438571610] 'process raft request' (duration: 212.180459ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.017793Z","caller":"traceutil/trace.go:171","msg":"trace[920556683] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"212.232841ms","start":"2026-08-20T16:52:59.805539Z","end":"2026-08-20T16:53:00.017772Z","steps":["trace[920556683] 'process raft request' (duration: 212.099445ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.018025Z","caller":"traceutil/trace.go:171","msg":"trace[1446034624] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"212.449751ms","start":"2026-08-20T16:52:59.805558Z","end":"2026-08-20T16:53:00.018008Z","steps":["trace[1446034624] 'process raft request' (duration: 212.104476ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.018637Z","caller":"traceutil/trace.go:171","msg":"trace[493572942] linearizableReadLoop","detail":"{readStateIndex:18; appliedIndex:11; }","duration":"156.765772ms","start":"2026-08-20T16:52:59.861853Z","end":"2026-08-20T16:53:00.018619Z","steps":["trace[493572942] 'read index received' (duration: 155.765339ms)","trace[493572942] 'applied index is now lower than readState.Index' (duration: 999.573µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:00.018819Z","caller":"traceutil/trace.go:171","msg":"trace[1666746722] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"213.130079ms","start":"2026-08-20T16:52:59.805635Z","end":"2026-08-20T16:53:00.018765Z","steps":["trace[1666746722] 'process raft request' (duration: 212.91934ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.018941Z","caller":"traceutil/trace.go:171","msg":"trace[1928107673] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"213.153391ms","start":"2026-08-20T16:52:59.805776Z","end":"2026-08-20T16:53:00.018929Z","steps":["trace[1928107673] 'process raft request' (duration: 212.798256ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.019156Z","caller":"traceutil/trace.go:171","msg":"trace[14949663] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"213.545847ms","start":"2026-08-20T16:52:59.805594Z","end":"2026-08-20T16:53:00.01914Z","steps":["trace[14949663] 'process raft request' (duration: 212.882259ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.019566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.699812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-20T16:53:00.019612Z","caller":"traceutil/trace.go:171","msg":"trace[1141094932] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:14; }","duration":"157.794686ms","start":"2026-08-20T16:52:59.861806Z","end":"2026-08-20T16:53:00.019601Z","steps":["trace[1141094932] 'agreement among raft nodes before linearized reading' (duration: 157.606828ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.01961Z","caller":"traceutil/trace.go:171","msg":"trace[1633342234] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"213.940284ms","start":"2026-08-20T16:52:59.805644Z","end":"2026-08-20T16:53:00.019584Z","steps":["trace[1633342234] 'process raft request' (duration: 212.878899ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.302533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.038168ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-20T16:53:00.302691Z","caller":"traceutil/trace.go:171","msg":"trace[425118257] linearizableReadLoop","detail":"{readStateIndex:19; appliedIndex:18; }","duration":"283.990498ms","start":"2026-08-20T16:53:00.018684Z","end":"2026-08-20T16:53:00.302674Z","steps":["trace[425118257] 'read index received' (duration: 71.785634ms)","trace[425118257] 'applied index is now lower than readState.Index' (duration: 212.203304ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:00.302779Z","caller":"traceutil/trace.go:171","msg":"trace[912115536] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"316.431192ms","start":"2026-08-20T16:52:59.986338Z","end":"2026-08-20T16:53:00.302769Z","steps":["trace[912115536] 'process raft request' (duration: 104.05376ms)","trace[912115536] 'compare' (duration: 211.85232ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:00.30286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:52:59.986315Z","time spent":"316.520275ms","remote":"127.0.0.1:56612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:53:00.303281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.097591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T16:53:00.303357Z","caller":"traceutil/trace.go:171","msg":"trace[2115939162] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:15; }","duration":"326.231536ms","start":"2026-08-20T16:52:59.977106Z","end":"2026-08-20T16:53:00.303338Z","steps":["trace[2115939162] 'agreement among raft nodes before linearized reading' (duration: 326.061239ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.303405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:52:59.977087Z","time spent":"326.306299ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-08-20T16:53:00.360757Z","caller":"traceutil/trace.go:171","msg":"trace[1211312770] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"338.869223ms","start":"2026-08-20T16:53:00.021859Z","end":"2026-08-20T16:53:00.360729Z","steps":["trace[1211312770] 'process raft request' (duration: 338.724797ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.360817Z","caller":"traceutil/trace.go:171","msg":"trace[61824736] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"338.712466ms","start":"2026-08-20T16:53:00.022084Z","end":"2026-08-20T16:53:00.360797Z","steps":["trace[61824736] 'process raft request' (duration: 338.596291ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.360939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.806714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-20T16:53:00.361009Z","caller":"traceutil/trace.go:171","msg":"trace[877552016] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"339.895497ms","start":"2026-08-20T16:53:00.021092Z","end":"2026-08-20T16:53:00.360988Z","steps":["trace[877552016] 'agreement among raft nodes before linearized reading' (duration: 339.740049ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.361058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.02108Z","time spent":"339.967791ms","remote":"127.0.0.1:56288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-20T16:53:00.360963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.022075Z","time spent":"338.811251ms","remote":"127.0.0.1:56276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:00.361036Z","caller":"traceutil/trace.go:171","msg":"trace[1395109319] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"337.909083ms","start":"2026-08-20T16:53:00.023059Z","end":"2026-08-20T16:53:00.360968Z","steps":["trace[1395109319] 'process raft request' (duration: 337.713014ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.361187Z","caller":"traceutil/trace.go:171","msg":"trace[1912482153] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"337.563079ms","start":"2026-08-20T16:53:00.023612Z","end":"2026-08-20T16:53:00.361175Z","steps":["trace[1912482153] 'process raft request' (duration: 337.188282ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.361262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.023564Z","time spent":"337.663873ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:53:00.3613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.016503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T16:53:00.361328Z","caller":"traceutil/trace.go:171","msg":"trace[1729369262] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:21; }","duration":"340.057844ms","start":"2026-08-20T16:53:00.021261Z","end":"2026-08-20T16:53:00.361319Z","steps":["trace[1729369262] 'agreement among raft nodes before linearized reading' (duration: 340.016122ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.361395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.021255Z","time spent":"340.131688ms","remote":"127.0.0.1:56276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-08-20T16:53:00.361089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.021842Z","time spent":"339.01285ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:53:00.361397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.02305Z","time spent":"338.153683ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:53:00.361132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.683922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T16:53:00.361744Z","caller":"traceutil/trace.go:171","msg":"trace[1282362738] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:21; }","duration":"325.310559ms","start":"2026-08-20T16:53:00.036406Z","end":"2026-08-20T16:53:00.361716Z","steps":["trace[1282362738] 'agreement among raft nodes before linearized reading' (duration: 324.643871ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.361823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.03639Z","time spent":"325.406152ms","remote":"127.0.0.1:56314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-08-20T16:53:00.361478Z","caller":"traceutil/trace.go:171","msg":"trace[785150411] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"338.912455ms","start":"2026-08-20T16:53:00.022545Z","end":"2026-08-20T16:53:00.361457Z","steps":["trace[785150411] 'process raft request' (duration: 338.166922ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.362011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.022517Z","time spent":"339.429577ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:00.361548Z","caller":"traceutil/trace.go:171","msg":"trace[2087988602] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"338.725907ms","start":"2026-08-20T16:53:00.022806Z","end":"2026-08-20T16:53:00.361532Z","steps":["trace[2087988602] 'process raft request' (duration: 337.940973ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.36221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.022796Z","time spent":"339.322833ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:53:00.743722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.984578ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-20T16:53:00.744008Z","caller":"traceutil/trace.go:171","msg":"trace[1003305024] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"437.115067ms","start":"2026-08-20T16:53:00.30686Z","end":"2026-08-20T16:53:00.743975Z","steps":["trace[1003305024] 'process raft request' (duration: 185.790126ms)","trace[1003305024] 'compare' (duration: 250.737957ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:00.744057Z","caller":"traceutil/trace.go:171","msg":"trace[634860724] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"437.075326ms","start":"2026-08-20T16:53:00.306959Z","end":"2026-08-20T16:53:00.744034Z","steps":["trace[634860724] 'process raft request' (duration: 436.897368ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.744213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.306834Z","time spent":"437.266464ms","remote":"127.0.0.1:56612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:00.74424Z","caller":"traceutil/trace.go:171","msg":"trace[1732762540] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"378.751343ms","start":"2026-08-20T16:53:00.365337Z","end":"2026-08-20T16:53:00.744088Z","steps":["trace[1732762540] 'process raft request' (duration: 378.605107ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.744248Z","caller":"traceutil/trace.go:171","msg":"trace[243538903] linearizableReadLoop","detail":"{readStateIndex:34; appliedIndex:25; }","duration":"376.013437ms","start":"2026-08-20T16:53:00.36817Z","end":"2026-08-20T16:53:00.744184Z","steps":["trace[243538903] 'read index received' (duration: 124.54897ms)","trace[243538903] 'applied index is now lower than readState.Index' (duration: 251.463647ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:00.744426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.306922Z","time spent":"437.378038ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:00.744476Z","caller":"traceutil/trace.go:171","msg":"trace[686207768] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"377.855445ms","start":"2026-08-20T16:53:00.366609Z","end":"2026-08-20T16:53:00.744465Z","steps":["trace[686207768] 'process raft request' (duration: 377.431317ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.744609Z","caller":"traceutil/trace.go:171","msg":"trace[486489469] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"376.949217ms","start":"2026-08-20T16:53:00.367649Z","end":"2026-08-20T16:53:00.744598Z","steps":["trace[486489469] 'process raft request' (duration: 376.512218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.744431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.365318Z","time spent":"379.039295ms","remote":"127.0.0.1:56352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:00.744719Z","caller":"traceutil/trace.go:171","msg":"trace[1521200311] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"377.71445ms","start":"2026-08-20T16:53:00.366998Z","end":"2026-08-20T16:53:00.744712Z","steps":["trace[1521200311] 'process raft request' (duration: 377.089143ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.744716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.366595Z","time spent":"378.014352ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:00.744845Z","caller":"traceutil/trace.go:171","msg":"trace[168683792] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"377.609895ms","start":"2026-08-20T16:53:00.367195Z","end":"2026-08-20T16:53:00.744805Z","steps":["trace[168683792] 'process raft request' (duration: 376.944086ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.744886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.700948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-20T16:53:00.744976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.367179Z","time spent":"377.755842ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:00.74501Z","caller":"traceutil/trace.go:171","msg":"trace[985186372] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:30; }","duration":"376.800121ms","start":"2026-08-20T16:53:00.368141Z","end":"2026-08-20T16:53:00.744941Z","steps":["trace[985186372] 'agreement among raft nodes before linearized reading' (duration: 376.613953ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.744757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.366981Z","time spent":"377.759162ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:00.744456Z","caller":"traceutil/trace.go:171","msg":"trace[1822255673] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"378.214981ms","start":"2026-08-20T16:53:00.366224Z","end":"2026-08-20T16:53:00.744439Z","steps":["trace[1822255673] 'process raft request' (duration: 377.768212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.744688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.367635Z","time spent":"377.023351ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:53:00.745257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.366193Z","time spent":"379.019055ms","remote":"127.0.0.1:56276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:00.744785Z","caller":"traceutil/trace.go:171","msg":"trace[128868397] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"377.590155ms","start":"2026-08-20T16:53:00.367188Z","end":"2026-08-20T16:53:00.744778Z","steps":["trace[128868397] 'process raft request' (duration: 376.924196ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.745375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.367176Z","time spent":"378.169929ms","remote":"127.0.0.1:56672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:53:00.745417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:00.368132Z","time spent":"377.262361ms","remote":"127.0.0.1:56250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"info","ts":"2026-08-20T16:53:00.976813Z","caller":"traceutil/trace.go:171","msg":"trace[1239474882] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"227.099526ms","start":"2026-08-20T16:53:00.749679Z","end":"2026-08-20T16:53:00.976779Z","steps":["trace[1239474882] 'process raft request' (duration: 166.635314ms)","trace[1239474882] 'compare' (duration: 60.195931ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:00.977641Z","caller":"traceutil/trace.go:171","msg":"trace[621796647] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"227.619368ms","start":"2026-08-20T16:53:00.750004Z","end":"2026-08-20T16:53:00.977624Z","steps":["trace[621796647] 'process raft request' (duration: 227.41861ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.977725Z","caller":"traceutil/trace.go:171","msg":"trace[1808430810] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"183.278709ms","start":"2026-08-20T16:53:00.794432Z","end":"2026-08-20T16:53:00.977711Z","steps":["trace[1808430810] 'process raft request' (duration: 183.244628ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.977825Z","caller":"traceutil/trace.go:171","msg":"trace[739968416] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"227.937372ms","start":"2026-08-20T16:53:00.74981Z","end":"2026-08-20T16:53:00.977747Z","steps":["trace[739968416] 'process raft request' (duration: 226.907527ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.977909Z","caller":"traceutil/trace.go:171","msg":"trace[1122614321] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"227.797916ms","start":"2026-08-20T16:53:00.750094Z","end":"2026-08-20T16:53:00.977892Z","steps":["trace[1122614321] 'process raft request' (duration: 227.460032ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.977955Z","caller":"traceutil/trace.go:171","msg":"trace[1854477129] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"227.256742ms","start":"2026-08-20T16:53:00.750691Z","end":"2026-08-20T16:53:00.977948Z","steps":["trace[1854477129] 'process raft request' (duration: 226.944199ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.97809Z","caller":"traceutil/trace.go:171","msg":"trace[1212859007] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"227.830647ms","start":"2026-08-20T16:53:00.750236Z","end":"2026-08-20T16:53:00.978067Z","steps":["trace[1212859007] 'process raft request' (duration: 227.377368ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.979254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.730452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T16:53:00.979341Z","caller":"traceutil/trace.go:171","msg":"trace[24428876] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:39; }","duration":"228.719074ms","start":"2026-08-20T16:53:00.750608Z","end":"2026-08-20T16:53:00.979327Z","steps":["trace[24428876] 'agreement among raft nodes before linearized reading' (duration: 227.68236ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.978249Z","caller":"traceutil/trace.go:171","msg":"trace[948918998] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"228.152061ms","start":"2026-08-20T16:53:00.750088Z","end":"2026-08-20T16:53:00.97824Z","steps":["trace[948918998] 'process raft request' (duration: 227.500464ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:00.978265Z","caller":"traceutil/trace.go:171","msg":"trace[2017572734] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:35; }","duration":"227.620668ms","start":"2026-08-20T16:53:00.750632Z","end":"2026-08-20T16:53:00.978253Z","steps":["trace[2017572734] 'read index received' (duration: 40.631722ms)","trace[2017572734] 'applied index is now lower than readState.Index' (duration: 186.987456ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:00.97979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.063718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T16:53:00.979836Z","caller":"traceutil/trace.go:171","msg":"trace[982172255] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:39; }","duration":"174.142691ms","start":"2026-08-20T16:53:00.805682Z","end":"2026-08-20T16:53:00.979825Z","steps":["trace[982172255] 'agreement among raft nodes before linearized reading' (duration: 174.061397ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:00.980019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.05542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T16:53:00.980084Z","caller":"traceutil/trace.go:171","msg":"trace[1377725761] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:39; }","duration":"192.142924ms","start":"2026-08-20T16:53:00.787929Z","end":"2026-08-20T16:53:00.980072Z","steps":["trace[1377725761] 'agreement among raft nodes before linearized reading' (duration: 191.812309ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:01.305469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.106564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-20T16:53:01.305733Z","caller":"traceutil/trace.go:171","msg":"trace[1497289844] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"282.844575ms","start":"2026-08-20T16:53:01.022876Z","end":"2026-08-20T16:53:01.305721Z","steps":["trace[1497289844] 'process raft request' (duration: 83.444459ms)","trace[1497289844] 'compare' (duration: 199.010979ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:01.306411Z","caller":"traceutil/trace.go:171","msg":"trace[1501893846] linearizableReadLoop","detail":"{readStateIndex:47; appliedIndex:45; }","duration":"266.064793ms","start":"2026-08-20T16:53:01.040324Z","end":"2026-08-20T16:53:01.306389Z","steps":["trace[1501893846] 'read index received' (duration: 66.012499ms)","trace[1501893846] 'applied index is now lower than readState.Index' (duration: 200.051324ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:01.306656Z","caller":"traceutil/trace.go:171","msg":"trace[1044725302] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"266.524452ms","start":"2026-08-20T16:53:01.040122Z","end":"2026-08-20T16:53:01.306647Z","steps":["trace[1044725302] 'process raft request' (duration: 266.065643ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:01.306787Z","caller":"traceutil/trace.go:171","msg":"trace[2040147949] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"260.959887ms","start":"2026-08-20T16:53:01.045821Z","end":"2026-08-20T16:53:01.306781Z","steps":["trace[2040147949] 'process raft request' (duration: 260.467646ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:01.306811Z","caller":"traceutil/trace.go:171","msg":"trace[642267640] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"206.639544ms","start":"2026-08-20T16:53:01.100153Z","end":"2026-08-20T16:53:01.306792Z","steps":["trace[642267640] 'process raft request' (duration: 206.202145ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:01.307113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.767063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T16:53:01.307209Z","caller":"traceutil/trace.go:171","msg":"trace[2016079176] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:45; }","duration":"266.899828ms","start":"2026-08-20T16:53:01.040293Z","end":"2026-08-20T16:53:01.307193Z","steps":["trace[2016079176] 'agreement among raft nodes before linearized reading' (duration: 266.287583ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:01.967467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.827846ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-20T16:53:01.967564Z","caller":"traceutil/trace.go:171","msg":"trace[22710471] linearizableReadLoop","detail":"{readStateIndex:127; appliedIndex:126; }","duration":"168.341729ms","start":"2026-08-20T16:53:01.799207Z","end":"2026-08-20T16:53:01.967549Z","steps":["trace[22710471] 'read index received' (duration: 63.318515ms)","trace[22710471] 'applied index is now lower than readState.Index' (duration: 105.022324ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:01.967621Z","caller":"traceutil/trace.go:171","msg":"trace[595935507] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"202.391763ms","start":"2026-08-20T16:53:01.765224Z","end":"2026-08-20T16:53:01.967615Z","steps":["trace[595935507] 'process raft request' (duration: 97.360099ms)","trace[595935507] 'compare' (duration: 104.69548ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:01.967799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.552051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T16:53:01.967989Z","caller":"traceutil/trace.go:171","msg":"trace[881680705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:123; }","duration":"161.775071ms","start":"2026-08-20T16:53:01.806192Z","end":"2026-08-20T16:53:01.967967Z","steps":["trace[881680705] 'agreement among raft nodes before linearized reading' (duration: 161.497069ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:01.967815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.610471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T16:53:01.968122Z","caller":"traceutil/trace.go:171","msg":"trace[757548048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:123; }","duration":"168.954575ms","start":"2026-08-20T16:53:01.799144Z","end":"2026-08-20T16:53:01.968099Z","steps":["trace[757548048] 'agreement among raft nodes before linearized reading' (duration: 168.534758ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:08.631978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.844962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-08-20T16:53:08.632053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.582949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-20T16:53:08.632087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.614974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-20T16:53:08.632072Z","caller":"traceutil/trace.go:171","msg":"trace[1817923266] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:335; }","duration":"473.992139ms","start":"2026-08-20T16:53:08.158055Z","end":"2026-08-20T16:53:08.632047Z","steps":["trace[1817923266] 'range keys from in-memory index tree' (duration: 473.707956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:08.632093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.829062ms","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-20T16:53:08.632126Z","caller":"traceutil/trace.go:171","msg":"trace[346436421] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:335; }","duration":"587.689707ms","start":"2026-08-20T16:53:08.044426Z","end":"2026-08-20T16:53:08.632116Z","steps":["trace[346436421] 'range keys from in-memory index tree' (duration: 587.449727ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:08.632164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:08.044406Z","time spent":"587.751799ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-20T16:53:08.632163Z","caller":"traceutil/trace.go:171","msg":"trace[1712002005] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:335; }","duration":"954.962548ms","start":"2026-08-20T16:53:07.677184Z","end":"2026-08-20T16:53:08.632147Z","steps":["trace[1712002005] 'range keys from in-memory index tree' (duration: 954.705518ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:08.632161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:08.158033Z","time spent":"474.113484ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-20T16:53:08.632203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:07.677161Z","time spent":"955.036001ms","remote":"127.0.0.1:56288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-20T16:53:08.632123Z","caller":"traceutil/trace.go:171","msg":"trace[105124914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:335; }","duration":"945.700714ms","start":"2026-08-20T16:53:07.686405Z","end":"2026-08-20T16:53:08.632106Z","steps":["trace[105124914] 'range keys from in-memory index tree' (duration: 945.469775ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:08.632237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:07.686387Z","time spent":"945.84289ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-20T16:53:09.152378Z","caller":"traceutil/trace.go:171","msg":"trace[79341829] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:371; }","duration":"211.575027ms","start":"2026-08-20T16:53:08.940787Z","end":"2026-08-20T16:53:09.152362Z","steps":["trace[79341829] 'read index received' (duration: 7.754321ms)","trace[79341829] 'applied index is now lower than readState.Index' (duration: 203.819946ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:09.152555Z","caller":"traceutil/trace.go:171","msg":"trace[1124659850] transaction","detail":"{read_only:false; number_of_response:1; response_revision:360; }","duration":"207.282404ms","start":"2026-08-20T16:53:08.945262Z","end":"2026-08-20T16:53:09.152545Z","steps":["trace[1124659850] 'process raft request' (duration: 207.071225ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:09.152558Z","caller":"traceutil/trace.go:171","msg":"trace[1072066053] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"213.574871ms","start":"2026-08-20T16:53:08.93895Z","end":"2026-08-20T16:53:09.152525Z","steps":["trace[1072066053] 'process raft request' (duration: 213.356222ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:09.152706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.159109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"warn","ts":"2026-08-20T16:53:09.152767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.908008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-08-20T16:53:09.152779Z","caller":"traceutil/trace.go:171","msg":"trace[2011295523] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:360; }","duration":"211.243743ms","start":"2026-08-20T16:53:08.941515Z","end":"2026-08-20T16:53:09.152759Z","steps":["trace[2011295523] 'agreement among raft nodes before linearized reading' (duration: 211.097827ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:09.152751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.946762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-08-20T16:53:09.152813Z","caller":"traceutil/trace.go:171","msg":"trace[32263585] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:360; }","duration":"124.991692ms","start":"2026-08-20T16:53:09.02781Z","end":"2026-08-20T16:53:09.152802Z","steps":["trace[32263585] 'agreement among raft nodes before linearized reading' (duration: 124.923029ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:09.15284Z","caller":"traceutil/trace.go:171","msg":"trace[1241911615] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:360; }","duration":"212.079238ms","start":"2026-08-20T16:53:08.940737Z","end":"2026-08-20T16:53:09.152817Z","steps":["trace[1241911615] 'agreement among raft nodes before linearized reading' (duration: 211.900701ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:09.152896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.571996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-08-20T16:53:09.152932Z","caller":"traceutil/trace.go:171","msg":"trace[1655795296] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:360; }","duration":"176.64406ms","start":"2026-08-20T16:53:08.976278Z","end":"2026-08-20T16:53:09.152922Z","steps":["trace[1655795296] 'agreement among raft nodes before linearized reading' (duration: 176.586227ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:09.152499Z","caller":"traceutil/trace.go:171","msg":"trace[1548001090] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"213.861924ms","start":"2026-08-20T16:53:08.938584Z","end":"2026-08-20T16:53:09.152446Z","steps":["trace[1548001090] 'process raft request' (duration: 133.443551ms)","trace[1548001090] 'compare' (duration: 80.215415ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:15.176029Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830813132098962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T16:53:15.211953Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.302782529s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T16:53:15.212276Z","caller":"traceutil/trace.go:171","msg":"trace[1265633048] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"1.303200014s","start":"2026-08-20T16:53:13.909056Z","end":"2026-08-20T16:53:15.212256Z","steps":["trace[1265633048] 'process raft request' (duration: 1.303073202s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:15.212546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:13.909043Z","time spent":"1.303295055s","remote":"127.0.0.1:56352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:53:15.250426Z","caller":"traceutil/trace.go:171","msg":"trace[92449132] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"347.331401ms","start":"2026-08-20T16:53:14.903057Z","end":"2026-08-20T16:53:15.250389Z","steps":["trace[92449132] 'process raft request' (duration: 342.939978ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:15.250602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:14.90303Z","time spent":"347.475114ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T16:53:15.250651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.449127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-20T16:53:15.250752Z","caller":"traceutil/trace.go:171","msg":"trace[84671869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:411; }","duration":"575.639839ms","start":"2026-08-20T16:53:14.675089Z","end":"2026-08-20T16:53:15.250729Z","steps":["trace[84671869] 'agreement among raft nodes before linearized reading' (duration: 575.402007ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:15.250821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:14.675072Z","time spent":"575.73363ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-20T16:53:15.250331Z","caller":"traceutil/trace.go:171","msg":"trace[24895623] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:426; }","duration":"575.130732ms","start":"2026-08-20T16:53:14.675155Z","end":"2026-08-20T16:53:15.250286Z","steps":["trace[24895623] 'read index received' (duration: 536.968762ms)","trace[24895623] 'applied index is now lower than readState.Index' (duration: 38.16014ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:15.251345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.346597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-20T16:53:15.251425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.261827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T16:53:15.251503Z","caller":"traceutil/trace.go:171","msg":"trace[2074222742] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:411; }","duration":"517.403968ms","start":"2026-08-20T16:53:14.734077Z","end":"2026-08-20T16:53:15.251481Z","steps":["trace[2074222742] 'agreement among raft nodes before linearized reading' (duration: 517.240206ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:15.251491Z","caller":"traceutil/trace.go:171","msg":"trace[935338326] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:411; }","duration":"517.53089ms","start":"2026-08-20T16:53:14.73394Z","end":"2026-08-20T16:53:15.251471Z","steps":["trace[935338326] 'agreement among raft nodes before linearized reading' (duration: 517.341898ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:15.251531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:14.734059Z","time spent":"517.466699ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-20T16:53:15.25155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:14.733919Z","time spent":"517.616251ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-20T16:53:21.186065Z","caller":"traceutil/trace.go:171","msg":"trace[626217859] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"355.387825ms","start":"2026-08-20T16:53:20.83065Z","end":"2026-08-20T16:53:21.186038Z","steps":["trace[626217859] 'process raft request' (duration: 354.870858ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:21.186205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:20.83063Z","time spent":"355.499386ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T16:53:21.699178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.300653ms","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-20T16:53:21.69927Z","caller":"traceutil/trace.go:171","msg":"trace[634396565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:428; }","duration":"240.447435ms","start":"2026-08-20T16:53:21.4588Z","end":"2026-08-20T16:53:21.699248Z","steps":["trace[634396565] 'range keys from in-memory index tree' (duration: 240.213332ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:21.699562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.224481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-20T16:53:21.699608Z","caller":"traceutil/trace.go:171","msg":"trace[972807516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:428; }","duration":"400.309642ms","start":"2026-08-20T16:53:21.299289Z","end":"2026-08-20T16:53:21.699599Z","steps":["trace[972807516] 'range keys from in-memory index tree' (duration: 400.104879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:21.699642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:21.299268Z","time spent":"400.365413ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-20T16:53:21.699836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.149517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T16:53:21.699875Z","caller":"traceutil/trace.go:171","msg":"trace[1847379316] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:428; }","duration":"390.209718ms","start":"2026-08-20T16:53:21.309656Z","end":"2026-08-20T16:53:21.699866Z","steps":["trace[1847379316] 'range keys from in-memory index tree' (duration: 390.062975ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:21.699902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:21.309646Z","time spent":"390.249839ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-20T16:53:21.700051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.109675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-20T16:53:21.700098Z","caller":"traceutil/trace.go:171","msg":"trace[826650123] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:428; }","duration":"390.175106ms","start":"2026-08-20T16:53:21.309913Z","end":"2026-08-20T16:53:21.700088Z","steps":["trace[826650123] 'range keys from in-memory index tree' (duration: 390.060745ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:21.700185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:21.309905Z","time spent":"390.269837ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-20T16:53:32.002457Z","caller":"traceutil/trace.go:171","msg":"trace[1142172862] linearizableReadLoop","detail":"{readStateIndex:503; appliedIndex:502; }","duration":"174.127011ms","start":"2026-08-20T16:53:31.828279Z","end":"2026-08-20T16:53:32.002406Z","steps":["trace[1142172862] 'read index received' (duration: 173.940698ms)","trace[1142172862] 'applied index is now lower than readState.Index' (duration: 185.373µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:32.002493Z","caller":"traceutil/trace.go:171","msg":"trace[976151692] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"182.676503ms","start":"2026-08-20T16:53:31.819798Z","end":"2026-08-20T16:53:32.002474Z","steps":["trace[976151692] 'process raft request' (duration: 182.471119ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:32.002688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.379275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-20T16:53:32.002716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.797496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T16:53:32.002765Z","caller":"traceutil/trace.go:171","msg":"trace[1517000438] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:482; }","duration":"173.869387ms","start":"2026-08-20T16:53:31.828882Z","end":"2026-08-20T16:53:32.002751Z","steps":["trace[1517000438] 'agreement among raft nodes before linearized reading' (duration: 173.783506ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:32.002765Z","caller":"traceutil/trace.go:171","msg":"trace[755226480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:482; }","duration":"174.490887ms","start":"2026-08-20T16:53:31.828256Z","end":"2026-08-20T16:53:32.002747Z","steps":["trace[755226480] 'agreement among raft nodes before linearized reading' (duration: 174.296824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:32.003049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.306014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-20T16:53:32.003092Z","caller":"traceutil/trace.go:171","msg":"trace[590758739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:482; }","duration":"174.364545ms","start":"2026-08-20T16:53:31.828717Z","end":"2026-08-20T16:53:32.003082Z","steps":["trace[590758739] 'agreement among raft nodes before linearized reading' (duration: 173.891958ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:32.227632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.443295ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:53:32.227759Z","caller":"traceutil/trace.go:171","msg":"trace[2019529878] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"221.110537ms","start":"2026-08-20T16:53:32.00663Z","end":"2026-08-20T16:53:32.227741Z","steps":["trace[2019529878] 'process raft request' (duration: 54.250415ms)","trace[2019529878] 'compare' (duration: 166.278973ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:32.265906Z","caller":"traceutil/trace.go:171","msg":"trace[975836050] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"258.389808ms","start":"2026-08-20T16:53:32.007479Z","end":"2026-08-20T16:53:32.265869Z","steps":["trace[975836050] 'process raft request' (duration: 258.333328ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:32.265964Z","caller":"traceutil/trace.go:171","msg":"trace[241905537] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"258.821235ms","start":"2026-08-20T16:53:32.007125Z","end":"2026-08-20T16:53:32.265946Z","steps":["trace[241905537] 'process raft request' (duration: 258.532639ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:34.469509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.714185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:53:34.469729Z","caller":"traceutil/trace.go:171","msg":"trace[1711523945] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"194.225342ms","start":"2026-08-20T16:53:34.275487Z","end":"2026-08-20T16:53:34.469712Z","steps":["trace[1711523945] 'process raft request' (duration: 194.159591ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:34.469798Z","caller":"traceutil/trace.go:171","msg":"trace[167172848] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"195.010104ms","start":"2026-08-20T16:53:34.274753Z","end":"2026-08-20T16:53:34.469764Z","steps":["trace[167172848] 'process raft request' (duration: 35.781391ms)","trace[167172848] 'compare' (duration: 158.643214ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:36.58576Z","caller":"traceutil/trace.go:171","msg":"trace[1850983227] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"106.591452ms","start":"2026-08-20T16:53:36.479144Z","end":"2026-08-20T16:53:36.585736Z","steps":["trace[1850983227] 'process raft request' (duration: 106.328988ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:37.703522Z","caller":"traceutil/trace.go:171","msg":"trace[1164002425] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"198.683635ms","start":"2026-08-20T16:53:37.504796Z","end":"2026-08-20T16:53:37.70348Z","steps":["trace[1164002425] 'process raft request' (duration: 198.217446ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:40.332737Z","caller":"traceutil/trace.go:171","msg":"trace[263327986] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"865.262636ms","start":"2026-08-20T16:53:39.467452Z","end":"2026-08-20T16:53:40.332714Z","steps":["trace[263327986] 'process raft request' (duration: 865.106753ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.332869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.467434Z","time spent":"865.377218ms","remote":"127.0.0.1:56226","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-20T16:53:40.479695Z","caller":"traceutil/trace.go:171","msg":"trace[715560319] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.00113226s","start":"2026-08-20T16:53:39.478545Z","end":"2026-08-20T16:53:40.479678Z","steps":["trace[715560319] 'process raft request' (duration: 1.001003527s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.480092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.478525Z","time spent":"1.001487916s","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:40.480175Z","caller":"traceutil/trace.go:171","msg":"trace[463669314] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"963.658536ms","start":"2026-08-20T16:53:39.516496Z","end":"2026-08-20T16:53:40.480154Z","steps":["trace[463669314] 'process raft request' (duration: 963.421812ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:40.479863Z","caller":"traceutil/trace.go:171","msg":"trace[696714644] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"978.780852ms","start":"2026-08-20T16:53:39.501062Z","end":"2026-08-20T16:53:40.479842Z","steps":["trace[696714644] 'process raft request' (duration: 978.589879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.480259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.516482Z","time spent":"963.733118ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:40.480098Z","caller":"traceutil/trace.go:171","msg":"trace[1560915280] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"973.448711ms","start":"2026-08-20T16:53:39.506634Z","end":"2026-08-20T16:53:40.480083Z","steps":["trace[1560915280] 'process raft request' (duration: 973.241378ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.480383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.506628Z","time spent":"973.714097ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:53:40.480384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.501053Z","time spent":"979.24413ms","remote":"127.0.0.1:56226","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-20T16:53:40.479923Z","caller":"traceutil/trace.go:171","msg":"trace[586010546] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"974.129563ms","start":"2026-08-20T16:53:39.50577Z","end":"2026-08-20T16:53:40.479899Z","steps":["trace[586010546] 'process raft request' (duration: 974.027722ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:40.480517Z","caller":"traceutil/trace.go:171","msg":"trace[371953683] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:556; }","duration":"373.680914ms","start":"2026-08-20T16:53:40.106809Z","end":"2026-08-20T16:53:40.48049Z","steps":["trace[371953683] 'read index received' (duration: 225.671605ms)","trace[371953683] 'applied index is now lower than readState.Index' (duration: 148.008149ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:40.480642Z","caller":"traceutil/trace.go:171","msg":"trace[1240866150] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"945.365117ms","start":"2026-08-20T16:53:39.535223Z","end":"2026-08-20T16:53:40.480588Z","steps":["trace[1240866150] 'process raft request' (duration: 945.008781ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.480727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.535209Z","time spent":"945.49381ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:53:40.480561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.505763Z","time spent":"974.770904ms","remote":"127.0.0.1:56226","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-20T16:53:40.480794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.967849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T16:53:40.48085Z","caller":"traceutil/trace.go:171","msg":"trace[1510102798] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:545; }","duration":"374.076901ms","start":"2026-08-20T16:53:40.106761Z","end":"2026-08-20T16:53:40.480837Z","steps":["trace[1510102798] 'agreement among raft nodes before linearized reading' (duration: 373.923329ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:40.480655Z","caller":"traceutil/trace.go:171","msg":"trace[1701797720] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"821.261469ms","start":"2026-08-20T16:53:39.659379Z","end":"2026-08-20T16:53:40.480641Z","steps":["trace[1701797720] 'process raft request' (duration: 821.029925ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.480905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:40.106742Z","time spent":"374.150613ms","remote":"127.0.0.1:56168","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-20T16:53:40.480935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.659346Z","time spent":"821.554484ms","remote":"127.0.0.1:56226","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-20T16:53:40.479956Z","caller":"traceutil/trace.go:171","msg":"trace[979297654] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"974.145413ms","start":"2026-08-20T16:53:39.505803Z","end":"2026-08-20T16:53:40.479949Z","steps":["trace[979297654] 'process raft request' (duration: 974.036611ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.481036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.5058Z","time spent":"975.213551ms","remote":"127.0.0.1:56226","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-20T16:53:40.480254Z","caller":"traceutil/trace.go:171","msg":"trace[107379298] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"959.209911ms","start":"2026-08-20T16:53:39.521033Z","end":"2026-08-20T16:53:40.480243Z","steps":["trace[107379298] 'process raft request' (duration: 959.035558ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.481184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.520761Z","time spent":"960.388181ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:40.479846Z","caller":"traceutil/trace.go:171","msg":"trace[1591001027] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"982.81202ms","start":"2026-08-20T16:53:39.497Z","end":"2026-08-20T16:53:40.479812Z","steps":["trace[1591001027] 'process raft request' (duration: 982.602436ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.481335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.496986Z","time spent":"984.288214ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T16:53:40.48146Z","caller":"traceutil/trace.go:171","msg":"trace[2022441285] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.008925142s","start":"2026-08-20T16:53:39.470693Z","end":"2026-08-20T16:53:40.479618Z","steps":["trace[2022441285] 'process raft request' (duration: 1.008684818s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.481592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:39.47067Z","time spent":"1.010889185s","remote":"127.0.0.1:56226","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-20T16:53:40.496541Z","caller":"traceutil/trace.go:171","msg":"trace[359440192] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"157.825337ms","start":"2026-08-20T16:53:40.338689Z","end":"2026-08-20T16:53:40.496515Z","steps":["trace[359440192] 'process raft request' (duration: 157.562583ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:40.496797Z","caller":"traceutil/trace.go:171","msg":"trace[1178156820] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"156.477854ms","start":"2026-08-20T16:53:40.340304Z","end":"2026-08-20T16:53:40.496782Z","steps":["trace[1178156820] 'process raft request' (duration: 156.100608ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:40.496889Z","caller":"traceutil/trace.go:171","msg":"trace[1950102264] transaction","detail":"{read_only:false; number_of_response:1; response_revision:547; }","duration":"156.21986ms","start":"2026-08-20T16:53:40.340665Z","end":"2026-08-20T16:53:40.496885Z","steps":["trace[1950102264] 'process raft request' (duration: 155.957025ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.496934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.943869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-20T16:53:40.496949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.961218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-20T16:53:40.496968Z","caller":"traceutil/trace.go:171","msg":"trace[1902907000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:547; }","duration":"199.015761ms","start":"2026-08-20T16:53:40.297944Z","end":"2026-08-20T16:53:40.49696Z","steps":["trace[1902907000] 'agreement among raft nodes before linearized reading' (duration: 198.864548ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:40.497003Z","caller":"traceutil/trace.go:171","msg":"trace[2044118686] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:547; }","duration":"378.029029ms","start":"2026-08-20T16:53:40.118949Z","end":"2026-08-20T16:53:40.496978Z","steps":["trace[2044118686] 'agreement among raft nodes before linearized reading' (duration: 377.873186ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:40.497032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:40.118938Z","time spent":"378.08798ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T16:53:47.484998Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830813132099408,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T16:53:47.918032Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.025353255s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T16:53:47.924721Z","caller":"traceutil/trace.go:171","msg":"trace[1763334841] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"940.266932ms","start":"2026-08-20T16:53:46.984392Z","end":"2026-08-20T16:53:47.924659Z","steps":["trace[1763334841] 'read index received' (duration: 933.747703ms)","trace[1763334841] 'applied index is now lower than readState.Index' (duration: 6.517799ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:47.924737Z","caller":"traceutil/trace.go:171","msg":"trace[1168922631] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.034074006s","start":"2026-08-20T16:53:46.890629Z","end":"2026-08-20T16:53:47.924703Z","steps":["trace[1168922631] 'process raft request' (duration: 1.028144307s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:47.924923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.520197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nqjf7\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-20T16:53:47.924975Z","caller":"traceutil/trace.go:171","msg":"trace[1557759922] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nqjf7; range_end:; response_count:1; response_revision:647; }","duration":"940.627228ms","start":"2026-08-20T16:53:46.984336Z","end":"2026-08-20T16:53:47.924964Z","steps":["trace[1557759922] 'agreement among raft nodes before linearized reading' (duration: 940.454895ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:47.925009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:46.984316Z","time spent":"940.68519ms","remote":"127.0.0.1:56352","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-nqjf7\" "} {"level":"warn","ts":"2026-08-20T16:53:47.925086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:46.890599Z","time spent":"1.034310929s","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T16:53:47.925255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.379564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T16:53:47.92537Z","caller":"traceutil/trace.go:171","msg":"trace[1702466636] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"818.557108ms","start":"2026-08-20T16:53:47.106792Z","end":"2026-08-20T16:53:47.925349Z","steps":["trace[1702466636] 'agreement among raft nodes before linearized reading' (duration: 818.326573ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:47.925451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:47.106772Z","time spent":"818.6705ms","remote":"127.0.0.1:56168","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-20T16:53:48.445589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.5624ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-20T16:53:48.865668Z","caller":"traceutil/trace.go:171","msg":"trace[1408399652] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"909.579302ms","start":"2026-08-20T16:53:47.95607Z","end":"2026-08-20T16:53:48.865649Z","steps":["trace[1408399652] 'process raft request' (duration: 909.44603ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:48.865784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:47.956047Z","time spent":"909.678034ms","remote":"127.0.0.1:56352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:53:48.87942Z","caller":"traceutil/trace.go:171","msg":"trace[588313716] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:677; }","duration":"329.460732ms","start":"2026-08-20T16:53:48.54993Z","end":"2026-08-20T16:53:48.879391Z","steps":["trace[588313716] 'read index received' (duration: 315.601176ms)","trace[588313716] 'applied index is now lower than readState.Index' (duration: 13.858356ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:48.879544Z","caller":"traceutil/trace.go:171","msg":"trace[324805406] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"881.773485ms","start":"2026-08-20T16:53:47.99776Z","end":"2026-08-20T16:53:48.879533Z","steps":["trace[324805406] 'process raft request' (duration: 881.48516ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:48.879644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:47.997733Z","time spent":"881.848977ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T16:53:48.8798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.187891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-20T16:53:48.879888Z","caller":"traceutil/trace.go:171","msg":"trace[2014020061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"326.319594ms","start":"2026-08-20T16:53:48.553547Z","end":"2026-08-20T16:53:48.879867Z","steps":["trace[2014020061] 'agreement among raft nodes before linearized reading' (duration: 326.0894ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:48.879934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:48.553528Z","time spent":"326.396235ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-20T16:53:48.879945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.813073ms","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-20T16:53:48.880018Z","caller":"traceutil/trace.go:171","msg":"trace[918627569] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:649; }","duration":"234.943054ms","start":"2026-08-20T16:53:48.645054Z","end":"2026-08-20T16:53:48.879997Z","steps":["trace[918627569] 'agreement among raft nodes before linearized reading' (duration: 234.69613ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:48.880176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.848379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T16:53:48.880219Z","caller":"traceutil/trace.go:171","msg":"trace[341247146] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"243.937231ms","start":"2026-08-20T16:53:48.63627Z","end":"2026-08-20T16:53:48.880207Z","steps":["trace[341247146] 'agreement among raft nodes before linearized reading' (duration: 243.783098ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:48.880226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.307038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-20T16:53:48.880266Z","caller":"traceutil/trace.go:171","msg":"trace[1710497282] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:649; }","duration":"330.38807ms","start":"2026-08-20T16:53:48.549866Z","end":"2026-08-20T16:53:48.880254Z","steps":["trace[1710497282] 'agreement among raft nodes before linearized reading' (duration: 330.295168ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:48.880296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:48.549836Z","time spent":"330.454281ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T16:53:51.106506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000117778s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-20T16:53:51.106623Z","caller":"traceutil/trace.go:171","msg":"trace[1151624075] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000285641s","start":"2026-08-20T16:53:49.106314Z","end":"2026-08-20T16:53:51.1066Z","steps":["trace[1151624075] 'agreement among raft nodes before linearized reading' (duration: 2.000140578s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:51.106684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:49.106297Z","time spent":"2.000373293s","remote":"127.0.0.1:56168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/20 16:53:51 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-20T16:53:51.457083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.378468466s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:53:51.457411Z","caller":"traceutil/trace.go:171","msg":"trace[256993334] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:679; }","duration":"2.563930989s","start":"2026-08-20T16:53:48.893463Z","end":"2026-08-20T16:53:51.457394Z","steps":["trace[256993334] 'read index received' (duration: 22.075029ms)","trace[256993334] 'applied index is now lower than readState.Index' (duration: 2.54185507s)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:51.457579Z","caller":"traceutil/trace.go:171","msg":"trace[187863959] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"2.565209341s","start":"2026-08-20T16:53:48.892333Z","end":"2026-08-20T16:53:51.457542Z","steps":["trace[187863959] 'process raft request' (duration: 2.565018898s)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:51.457636Z","caller":"traceutil/trace.go:171","msg":"trace[210208261] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"2.572308883s","start":"2026-08-20T16:53:48.885306Z","end":"2026-08-20T16:53:51.457615Z","steps":["trace[210208261] 'process raft request' (duration: 193.181994ms)","trace[210208261] 'compare' (duration: 2.378341514s)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:51.457712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:48.892309Z","time spent":"2.565333243s","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T16:53:51.45774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:48.885294Z","time spent":"2.572390485s","remote":"127.0.0.1:56444","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-20T16:53:51.457765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.466445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-20T16:53:51.457804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.564330446s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-20T16:53:51.457839Z","caller":"traceutil/trace.go:171","msg":"trace[1716766532] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"2.565583569s","start":"2026-08-20T16:53:48.892245Z","end":"2026-08-20T16:53:51.457829Z","steps":["trace[1716766532] 'process raft request' (duration: 2.564933387s)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:53:51.457856Z","caller":"traceutil/trace.go:171","msg":"trace[972444066] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:653; }","duration":"2.564400687s","start":"2026-08-20T16:53:48.893439Z","end":"2026-08-20T16:53:51.45784Z","steps":["trace[972444066] 'agreement among raft nodes before linearized reading' (duration: 2.564314945s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:51.457886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:48.892222Z","time spent":"2.565640139s","remote":"127.0.0.1:56444","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-20T16:53:51.457913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:48.893432Z","time spent":"2.564470709s","remote":"127.0.0.1:56374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-08-20T16:53:51.457912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.10561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T16:53:51.457854Z","caller":"traceutil/trace.go:171","msg":"trace[207420231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:653; }","duration":"538.597987ms","start":"2026-08-20T16:53:50.919234Z","end":"2026-08-20T16:53:51.457832Z","steps":["trace[207420231] 'agreement among raft nodes before linearized reading' (duration: 538.351062ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:51.45804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:50.919215Z","time spent":"538.799352ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-20T16:53:51.457974Z","caller":"traceutil/trace.go:171","msg":"trace[38996702] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"351.197382ms","start":"2026-08-20T16:53:51.106765Z","end":"2026-08-20T16:53:51.457963Z","steps":["trace[38996702] 'agreement among raft nodes before linearized reading' (duration: 351.119891ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:51.458668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:51.106748Z","time spent":"351.902675ms","remote":"127.0.0.1:56178","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-20T16:53:55.586281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.656425ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:53:55.586561Z","caller":"traceutil/trace.go:171","msg":"trace[514540457] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"437.550759ms","start":"2026-08-20T16:53:55.148986Z","end":"2026-08-20T16:53:55.586537Z","steps":["trace[514540457] 'process raft request' (duration: 437.415026ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:55.586725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:55.148976Z","time spent":"437.647661ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:53:55.586768Z","caller":"traceutil/trace.go:171","msg":"trace[537406562] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"437.753543ms","start":"2026-08-20T16:53:55.148982Z","end":"2026-08-20T16:53:55.586735Z","steps":["trace[537406562] 'process raft request' (duration: 69.549647ms)","trace[537406562] 'compare' (duration: 367.488822ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:53:55.586925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:53:55.148968Z","time spent":"437.873505ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5571,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:53:55.611211Z","caller":"traceutil/trace.go:171","msg":"trace[645073154] linearizableReadLoop","detail":"{readStateIndex:729; appliedIndex:728; }","duration":"136.754487ms","start":"2026-08-20T16:53:55.474445Z","end":"2026-08-20T16:53:55.6112Z","steps":["trace[645073154] 'read index received' (duration: 136.691146ms)","trace[645073154] 'applied index is now lower than readState.Index' (duration: 62.481µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:53:55.611223Z","caller":"traceutil/trace.go:171","msg":"trace[77356511] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"287.429357ms","start":"2026-08-20T16:53:55.323778Z","end":"2026-08-20T16:53:55.611207Z","steps":["trace[77356511] 'process raft request' (duration: 287.331105ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:55.611437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.997221ms","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-20T16:53:55.611469Z","caller":"traceutil/trace.go:171","msg":"trace[1051993284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:698; }","duration":"137.079393ms","start":"2026-08-20T16:53:55.474381Z","end":"2026-08-20T16:53:55.611461Z","steps":["trace[1051993284] 'agreement among raft nodes before linearized reading' (duration: 136.878969ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:55.611558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.112643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-20T16:53:55.611642Z","caller":"traceutil/trace.go:171","msg":"trace[1624392835] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:698; }","duration":"137.247606ms","start":"2026-08-20T16:53:55.474381Z","end":"2026-08-20T16:53:55.611629Z","steps":["trace[1624392835] 'agreement among raft nodes before linearized reading' (duration: 136.994581ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:55.619155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.592131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T16:53:55.619212Z","caller":"traceutil/trace.go:171","msg":"trace[1658705995] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:700; }","duration":"144.678142ms","start":"2026-08-20T16:53:55.474524Z","end":"2026-08-20T16:53:55.619202Z","steps":["trace[1658705995] 'agreement among raft nodes before linearized reading' (duration: 144.519209ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:53:55.619511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.715485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-20T16:53:55.619567Z","caller":"traceutil/trace.go:171","msg":"trace[1273147477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:700; }","duration":"140.788896ms","start":"2026-08-20T16:53:55.478762Z","end":"2026-08-20T16:53:55.619551Z","steps":["trace[1273147477] 'agreement among raft nodes before linearized reading' (duration: 140.508861ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:54:08.43705Z","caller":"traceutil/trace.go:171","msg":"trace[1137707294] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"740.602297ms","start":"2026-08-20T16:54:07.696417Z","end":"2026-08-20T16:54:08.437019Z","steps":["trace[1137707294] 'process raft request' (duration: 740.451972ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:54:08.437227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:54:07.696403Z","time spent":"740.746829ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:54:08.562831Z","caller":"traceutil/trace.go:171","msg":"trace[1059567624] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"866.349207ms","start":"2026-08-20T16:54:07.696458Z","end":"2026-08-20T16:54:08.562807Z","steps":["trace[1059567624] 'process raft request' (duration: 866.108562ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:54:08.562824Z","caller":"traceutil/trace.go:171","msg":"trace[1373231468] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"866.240995ms","start":"2026-08-20T16:54:07.696561Z","end":"2026-08-20T16:54:08.562802Z","steps":["trace[1373231468] 'process raft request' (duration: 866.150063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:54:08.562993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:54:07.696441Z","time spent":"866.455709ms","remote":"127.0.0.1:56444","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-20T16:54:08.563226Z","caller":"traceutil/trace.go:171","msg":"trace[919835284] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"866.586413ms","start":"2026-08-20T16:54:07.696614Z","end":"2026-08-20T16:54:08.5632Z","steps":["trace[919835284] 'process raft request' (duration: 866.146102ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:54:08.56343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:54:07.696606Z","time spent":"866.692446ms","remote":"127.0.0.1:56444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T16:54:08.56398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:54:07.696553Z","time spent":"866.355697ms","remote":"127.0.0.1:56444","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-20T16:54:08.572142Z","caller":"traceutil/trace.go:171","msg":"trace[415043772] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:855; }","duration":"466.442056ms","start":"2026-08-20T16:54:08.10568Z","end":"2026-08-20T16:54:08.572122Z","steps":["trace[415043772] 'read index received' (duration: 331.25258ms)","trace[415043772] 'applied index is now lower than readState.Index' (duration: 135.188456ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:54:08.57227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.57856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T16:54:08.5723Z","caller":"traceutil/trace.go:171","msg":"trace[1907484749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:825; }","duration":"466.660791ms","start":"2026-08-20T16:54:08.10563Z","end":"2026-08-20T16:54:08.572291Z","steps":["trace[1907484749] 'agreement among raft nodes before linearized reading' (duration: 466.59239ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:54:08.572327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:54:08.105612Z","time spent":"466.709753ms","remote":"127.0.0.1:56178","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-20T16:54:08.572273Z","caller":"traceutil/trace.go:171","msg":"trace[1815797045] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"462.368918ms","start":"2026-08-20T16:54:08.109823Z","end":"2026-08-20T16:54:08.572192Z","steps":["trace[1815797045] 'process raft request' (duration: 462.178564ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:54:08.572546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:54:08.10974Z","time spent":"462.729596ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T16:55:27.641998Z","caller":"traceutil/trace.go:171","msg":"trace[1343829659] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"206.393268ms","start":"2026-08-20T16:55:27.435579Z","end":"2026-08-20T16:55:27.641972Z","steps":["trace[1343829659] 'process raft request' (duration: 206.246213ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:55:29.022616Z","caller":"traceutil/trace.go:171","msg":"trace[1621685726] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"123.217724ms","start":"2026-08-20T16:55:28.899373Z","end":"2026-08-20T16:55:29.02259Z","steps":["trace[1621685726] 'process raft request' (duration: 123.050509ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:55:29.16465Z","caller":"traceutil/trace.go:171","msg":"trace[1853239118] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1271; }","duration":"111.014602ms","start":"2026-08-20T16:55:29.053615Z","end":"2026-08-20T16:55:29.16463Z","steps":["trace[1853239118] 'read index received' (duration: 17.965855ms)","trace[1853239118] 'applied index is now lower than readState.Index' (duration: 93.047857ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T16:55:29.164784Z","caller":"traceutil/trace.go:171","msg":"trace[1462524697] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"122.519422ms","start":"2026-08-20T16:55:29.042231Z","end":"2026-08-20T16:55:29.164751Z","steps":["trace[1462524697] 'process raft request' (duration: 29.382912ms)","trace[1462524697] 'compare' (duration: 92.882772ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:55:29.164896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.263209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-20T16:55:29.164938Z","caller":"traceutil/trace.go:171","msg":"trace[761565595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1218; }","duration":"111.351653ms","start":"2026-08-20T16:55:29.053576Z","end":"2026-08-20T16:55:29.164927Z","steps":["trace[761565595] 'agreement among raft nodes before linearized reading' (duration: 111.173638ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:55:29.165017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.171417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-20T16:55:29.165111Z","caller":"traceutil/trace.go:171","msg":"trace[787316134] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1218; }","duration":"111.296611ms","start":"2026-08-20T16:55:29.053795Z","end":"2026-08-20T16:55:29.165091Z","steps":["trace[787316134] 'agreement among raft nodes before linearized reading' (duration: 111.038773ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:55:29.504149Z","caller":"traceutil/trace.go:171","msg":"trace[804497354] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"334.690337ms","start":"2026-08-20T16:55:29.169427Z","end":"2026-08-20T16:55:29.504118Z","steps":["trace[804497354] 'process raft request' (duration: 290.595327ms)","trace[804497354] 'compare' (duration: 43.823302ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:55:29.504308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:55:29.169409Z","time spent":"334.809361ms","remote":"127.0.0.1:56444","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-20T16:55:29.894493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.226269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-20T16:55:29.894599Z","caller":"traceutil/trace.go:171","msg":"trace[310005417] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1221; }","duration":"113.407114ms","start":"2026-08-20T16:55:29.78116Z","end":"2026-08-20T16:55:29.894568Z","steps":["trace[310005417] 'range keys from in-memory index tree' (duration: 112.93549ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:55:33.125263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.023865ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T16:55:33.125504Z","caller":"traceutil/trace.go:171","msg":"trace[1243075789] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"163.396489ms","start":"2026-08-20T16:55:32.962055Z","end":"2026-08-20T16:55:33.125452Z","steps":["trace[1243075789] 'process raft request' (duration: 52.100686ms)","trace[1243075789] 'compare' (duration: 110.883151ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T16:55:33.353711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.962238ms","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-20T16:55:33.353786Z","caller":"traceutil/trace.go:171","msg":"trace[497008388] 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:1231; }","duration":"102.081541ms","start":"2026-08-20T16:55:33.251687Z","end":"2026-08-20T16:55:33.353769Z","steps":["trace[497008388] 'count revisions from in-memory index tree' (duration: 101.905076ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T16:55:56.208966Z","caller":"traceutil/trace.go:171","msg":"trace[1152018972] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"101.597586ms","start":"2026-08-20T16:55:56.107328Z","end":"2026-08-20T16:55:56.208926Z","steps":["trace[1152018972] 'process raft request' (duration: 101.356268ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:56:04.723885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.038817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T16:56:04.723968Z","caller":"traceutil/trace.go:171","msg":"trace[1038648928] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1371; }","duration":"386.175862ms","start":"2026-08-20T16:56:04.337775Z","end":"2026-08-20T16:56:04.723951Z","steps":["trace[1038648928] 'count revisions from in-memory index tree' (duration: 385.955925ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T16:56:04.724279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T16:56:04.337757Z","time spent":"386.504793ms","remote":"127.0.0.1:57134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":5,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "}