{"level":"warn","ts":"2026-06-10T08:00:28.423358Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T08:00:28.423498Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-06-10T08:00:28.423569Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T08:00:28.423583Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-06-10T08:00:28.423608Z","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-06-10T08:00:28.42424Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-06-10T08:00:28.42432Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-06-10T08:00:28.43364Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.132364ms"} {"level":"info","ts":"2026-06-10T08:00:28.4441Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-06-10T08:00:28.444163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T08:00:28.444183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-06-10T08:00:28.444195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T08:00:28.444203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-06-10T08:00:28.444238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-06-10T08:00:28.458977Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T08:00:28.460784Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T08:00:28.463392Z","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-06-10T08:00:28.466911Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T08:00:28.46709Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T08:00:28.467087Z","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-06-10T08:00:28.467562Z","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-06-10T08:00:28.46758Z","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-06-10T08:00:28.467915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-06-10T08:00:28.468049Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-06-10T08:00:28.471941Z","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-06-10T08:00:28.472865Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-06-10T08:00:28.473Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-06-10T08:00:28.473221Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T08:00:28.473274Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T08:00:28.846058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T08:00:28.846131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T08:00:28.846344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-06-10T08:00:28.846439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-06-10T08:00:28.846463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-06-10T08:00:28.846542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-06-10T08:00:28.846649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-06-10T08:00:28.847829Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:00:28.8487Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T08:00:28.848851Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:00:28.849201Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:00:28.849258Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:00:28.849419Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:00:28.849479Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:00:28.849595Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T08:00:28.849652Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T08:00:28.852023Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-06-10T08:00:28.852974Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-10T08:00:30.608044Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226752844832117,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T08:00:30.985815Z","caller":"traceutil/trace.go:171","msg":"trace[1275226629] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"879.541574ms","start":"2026-06-10T08:00:30.10625Z","end":"2026-06-10T08:00:30.985792Z","steps":["trace[1275226629] 'process raft request' (duration: 879.332673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:30.986421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.106237Z","time spent":"879.650215ms","remote":"127.0.0.1:52644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:00:32.897389Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.911754228s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T08:00:32.89777Z","caller":"traceutil/trace.go:171","msg":"trace[57596268] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"2.709908731s","start":"2026-06-10T08:00:30.187815Z","end":"2026-06-10T08:00:32.897724Z","steps":["trace[57596268] 'process raft request' (duration: 2.70971966s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:32.897785Z","caller":"traceutil/trace.go:171","msg":"trace[1654588551] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"2.709690659s","start":"2026-06-10T08:00:30.188062Z","end":"2026-06-10T08:00:32.897753Z","steps":["trace[1654588551] 'process raft request' (duration: 2.709599818s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:32.89788Z","caller":"traceutil/trace.go:171","msg":"trace[1902382223] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:4; }","duration":"2.790182424s","start":"2026-06-10T08:00:30.107678Z","end":"2026-06-10T08:00:32.897861Z","steps":["trace[1902382223] 'read index received' (duration: 877.936363ms)","trace[1902382223] 'applied index is now lower than readState.Index' (duration: 1.912245211s)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:00:32.897959Z","caller":"traceutil/trace.go:171","msg":"trace[691834141] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"2.709690489s","start":"2026-06-10T08:00:30.18826Z","end":"2026-06-10T08:00:32.897951Z","steps":["trace[691834141] 'process raft request' (duration: 2.709505178s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.897971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.188051Z","time spent":"2.70982203s","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:32.897973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.187797Z","time spent":"2.710076862s","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:32.898037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.188241Z","time spent":"2.70974368s","remote":"127.0.0.1:53018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:32.898057Z","caller":"traceutil/trace.go:171","msg":"trace[801241971] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"2.70974848s","start":"2026-06-10T08:00:30.188277Z","end":"2026-06-10T08:00:32.898026Z","steps":["trace[801241971] 'process raft request' (duration: 2.709416368s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:32.898086Z","caller":"traceutil/trace.go:171","msg":"trace[755821175] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"2.709168046s","start":"2026-06-10T08:00:30.188873Z","end":"2026-06-10T08:00:32.898041Z","steps":["trace[755821175] 'process raft request' (duration: 2.708872884s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.898137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.188268Z","time spent":"2.70983009s","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:32.898142Z","caller":"traceutil/trace.go:171","msg":"trace[1325141373] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"2.693026624s","start":"2026-06-10T08:00:30.205093Z","end":"2026-06-10T08:00:32.89812Z","steps":["trace[1325141373] 'process raft request' (duration: 2.692737363s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.898206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.205074Z","time spent":"2.693103195s","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:32.898209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.188838Z","time spent":"2.709307407s","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:32.898343Z","caller":"traceutil/trace.go:171","msg":"trace[643525174] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"2.709485358s","start":"2026-06-10T08:00:30.188848Z","end":"2026-06-10T08:00:32.898333Z","steps":["trace[643525174] 'process raft request' (duration: 2.708871534s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.898384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.188806Z","time spent":"2.709558448s","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:32.898401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.790620606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:00:32.898392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.790700107s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-06-10T08:00:32.898464Z","caller":"traceutil/trace.go:171","msg":"trace[1714600887] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:10; }","duration":"2.790680917s","start":"2026-06-10T08:00:30.107767Z","end":"2026-06-10T08:00:32.898448Z","steps":["trace[1714600887] 'agreement among raft nodes before linearized reading' (duration: 2.790553546s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:32.898482Z","caller":"traceutil/trace.go:171","msg":"trace[1904766555] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"2.790821128s","start":"2026-06-10T08:00:30.10765Z","end":"2026-06-10T08:00:32.898471Z","steps":["trace[1904766555] 'agreement among raft nodes before linearized reading' (duration: 2.790643847s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.898502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.107751Z","time spent":"2.790742187s","remote":"127.0.0.1:52648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":26,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-06-10T08:00:32.898511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.107637Z","time spent":"2.790866558s","remote":"127.0.0.1:52746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-10T08:00:32.898544Z","caller":"traceutil/trace.go:171","msg":"trace[1665175403] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"2.698331051s","start":"2026-06-10T08:00:30.200197Z","end":"2026-06-10T08:00:32.898528Z","steps":["trace[1665175403] 'process raft request' (duration: 2.697605776s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.898615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.200184Z","time spent":"2.698399262s","remote":"127.0.0.1:52746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:32.898654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.546819055s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:00:32.898684Z","caller":"traceutil/trace.go:171","msg":"trace[1227166040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10; }","duration":"1.546891465s","start":"2026-06-10T08:00:31.351783Z","end":"2026-06-10T08:00:32.898674Z","steps":["trace[1227166040] 'agreement among raft nodes before linearized reading' (duration: 1.546849945s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.898708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:31.351753Z","time spent":"1.546950075s","remote":"127.0.0.1:52562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T08:00:32.898754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.710687936s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:00:32.898785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.81266486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:00:32.898803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.659670135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:00:32.898826Z","caller":"traceutil/trace.go:171","msg":"trace[1124566425] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"1.81274617s","start":"2026-06-10T08:00:31.086069Z","end":"2026-06-10T08:00:32.898815Z","steps":["trace[1124566425] 'agreement among raft nodes before linearized reading' (duration: 1.81267755s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:32.898825Z","caller":"traceutil/trace.go:171","msg":"trace[1557171604] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"2.710764726s","start":"2026-06-10T08:00:30.188029Z","end":"2026-06-10T08:00:32.898794Z","steps":["trace[1557171604] 'agreement among raft nodes before linearized reading' (duration: 2.710669385s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:32.898834Z","caller":"traceutil/trace.go:171","msg":"trace[1211079637] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.659700365s","start":"2026-06-10T08:00:30.239124Z","end":"2026-06-10T08:00:32.898825Z","steps":["trace[1211079637] 'agreement among raft nodes before linearized reading' (duration: 2.659656465s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.898857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:31.08604Z","time spent":"1.81281068s","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-06-10T08:00:32.898867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.239113Z","time spent":"2.659748195s","remote":"127.0.0.1:52698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-10T08:00:32.898871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.712916541s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:00:32.898875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.188017Z","time spent":"2.710843937s","remote":"127.0.0.1:52666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-06-10T08:00:32.898896Z","caller":"traceutil/trace.go:171","msg":"trace[1992747554] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:0; response_revision:10; }","duration":"2.712984802s","start":"2026-06-10T08:00:30.185903Z","end":"2026-06-10T08:00:32.898888Z","steps":["trace[1992747554] 'agreement among raft nodes before linearized reading' (duration: 2.712954271s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.898839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.711181589s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:00:32.898988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.811995425s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:00:32.898993Z","caller":"traceutil/trace.go:171","msg":"trace[31333991] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.71135611s","start":"2026-06-10T08:00:30.187623Z","end":"2026-06-10T08:00:32.898979Z","steps":["trace[31333991] 'agreement among raft nodes before linearized reading' (duration: 2.711197489s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:32.899017Z","caller":"traceutil/trace.go:171","msg":"trace[1645821612] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"1.812042245s","start":"2026-06-10T08:00:31.086966Z","end":"2026-06-10T08:00:32.899008Z","steps":["trace[1645821612] 'agreement among raft nodes before linearized reading' (duration: 1.812002715s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.899022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.187603Z","time spent":"2.71141205s","remote":"127.0.0.1:52698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-10T08:00:32.899042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:31.086955Z","time spent":"1.812080826s","remote":"127.0.0.1:52930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-06-10T08:00:32.899177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.739067381s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-10T08:00:32.899222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.185872Z","time spent":"2.713043802s","remote":"127.0.0.1:52602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.223\" "} {"level":"info","ts":"2026-06-10T08:00:32.899226Z","caller":"traceutil/trace.go:171","msg":"trace[540586248] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.739143432s","start":"2026-06-10T08:00:30.160067Z","end":"2026-06-10T08:00:32.899211Z","steps":["trace[540586248] 'agreement among raft nodes before linearized reading' (duration: 2.739069371s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:32.899268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:30.160041Z","time spent":"2.739213982s","remote":"127.0.0.1:52698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-10T08:00:33.404265Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226752844832129,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:00:33.95742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.851803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-06-10T08:00:33.957663Z","caller":"traceutil/trace.go:171","msg":"trace[1985002337] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.054514238s","start":"2026-06-10T08:00:32.90312Z","end":"2026-06-10T08:00:33.957634Z","steps":["trace[1985002337] 'process raft request' (duration: 533.206482ms)","trace[1985002337] 'compare' (duration: 520.672622ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:00:33.957797Z","caller":"traceutil/trace.go:171","msg":"trace[89306319] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"1.053976175s","start":"2026-06-10T08:00:32.90374Z","end":"2026-06-10T08:00:33.957716Z","steps":["trace[89306319] 'process raft request' (duration: 1.053813044s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.957837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.903102Z","time spent":"1.054621839s","remote":"127.0.0.1:52648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:00:33.957855Z","caller":"traceutil/trace.go:171","msg":"trace[536183387] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"1.053582562s","start":"2026-06-10T08:00:32.904259Z","end":"2026-06-10T08:00:33.957841Z","steps":["trace[536183387] 'process raft request' (duration: 1.05334819s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.957946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.903727Z","time spent":"1.054152446s","remote":"127.0.0.1:52698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:33.957948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.90425Z","time spent":"1.053653122s","remote":"127.0.0.1:52698","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:33.958127Z","caller":"traceutil/trace.go:171","msg":"trace[1979109181] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"1.053568202s","start":"2026-06-10T08:00:32.904544Z","end":"2026-06-10T08:00:33.958112Z","steps":["trace[1979109181] 'process raft request' (duration: 1.053081768s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.958184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.904524Z","time spent":"1.053639532s","remote":"127.0.0.1:52970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:33.958269Z","caller":"traceutil/trace.go:171","msg":"trace[1224865001] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"1.05326666s","start":"2026-06-10T08:00:32.904992Z","end":"2026-06-10T08:00:33.958259Z","steps":["trace[1224865001] 'process raft request' (duration: 1.053054828s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.958349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.904977Z","time spent":"1.05331807s","remote":"127.0.0.1:52944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:33.958323Z","caller":"traceutil/trace.go:171","msg":"trace[280879782] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"1.053039018s","start":"2026-06-10T08:00:32.905241Z","end":"2026-06-10T08:00:33.95828Z","steps":["trace[280879782] 'process raft request' (duration: 1.052855977s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:33.958385Z","caller":"traceutil/trace.go:171","msg":"trace[167649608] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"1.052622895s","start":"2026-06-10T08:00:32.905752Z","end":"2026-06-10T08:00:33.958375Z","steps":["trace[167649608] 'process raft request' (duration: 1.052382814s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.958431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.905741Z","time spent":"1.052669866s","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:33.958497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.90523Z","time spent":"1.05318638s","remote":"127.0.0.1:53018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:33.958581Z","caller":"traceutil/trace.go:171","msg":"trace[1649402244] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"1.052648866s","start":"2026-06-10T08:00:32.905923Z","end":"2026-06-10T08:00:33.958572Z","steps":["trace[1649402244] 'process raft request' (duration: 1.052268763s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.958629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.905915Z","time spent":"1.052695446s","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:33.958805Z","caller":"traceutil/trace.go:171","msg":"trace[1973904838] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"1.052261883s","start":"2026-06-10T08:00:32.906528Z","end":"2026-06-10T08:00:33.95879Z","steps":["trace[1973904838] 'process raft request' (duration: 1.05185572s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.958905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.906519Z","time spent":"1.052329194s","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:33.958985Z","caller":"traceutil/trace.go:171","msg":"trace[2013569059] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"1.052228602s","start":"2026-06-10T08:00:32.906743Z","end":"2026-06-10T08:00:33.958971Z","steps":["trace[2013569059] 'process raft request' (duration: 1.051799539s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.959061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.906735Z","time spent":"1.052292363s","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:00:33.959271Z","caller":"traceutil/trace.go:171","msg":"trace[411080815] linearizableReadLoop","detail":"{readStateIndex:25; appliedIndex:13; }","duration":"1.055740146s","start":"2026-06-10T08:00:32.90351Z","end":"2026-06-10T08:00:33.95925Z","steps":["trace[411080815] 'read index received' (duration: 532.95955ms)","trace[411080815] 'applied index is now lower than readState.Index' (duration: 522.779656ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:00:33.959382Z","caller":"traceutil/trace.go:171","msg":"trace[344231650] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"1.05192861s","start":"2026-06-10T08:00:32.907442Z","end":"2026-06-10T08:00:33.959371Z","steps":["trace[344231650] 'process raft request' (duration: 1.051401886s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.959443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.907436Z","time spent":"1.051974381s","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:00:33.95972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.056198969s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-10T08:00:33.959866Z","caller":"traceutil/trace.go:171","msg":"trace[1744731333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"1.05632573s","start":"2026-06-10T08:00:32.903486Z","end":"2026-06-10T08:00:33.959811Z","steps":["trace[1744731333] 'agreement among raft nodes before linearized reading' (duration: 1.056110839s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.95999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.903477Z","time spent":"1.05641276s","remote":"127.0.0.1:52562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T08:00:33.960268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.056034048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-472jk\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-06-10T08:00:33.960304Z","caller":"traceutil/trace.go:171","msg":"trace[1416148431] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"1.047814742s","start":"2026-06-10T08:00:32.912481Z","end":"2026-06-10T08:00:33.960295Z","steps":["trace[1416148431] 'process raft request' (duration: 1.046703455s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:33.96031Z","caller":"traceutil/trace.go:171","msg":"trace[819357074] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-472jk; range_end:; response_count:1; response_revision:21; }","duration":"1.056097529s","start":"2026-06-10T08:00:32.904201Z","end":"2026-06-10T08:00:33.960298Z","steps":["trace[819357074] 'agreement among raft nodes before linearized reading' (duration: 1.055978738s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.960344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.904193Z","time spent":"1.056144289s","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":879,"request content":"key:\"/registry/certificatesigningrequests/csr-472jk\" "} {"level":"warn","ts":"2026-06-10T08:00:33.960668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.384413ms","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-06-10T08:00:33.960708Z","caller":"traceutil/trace.go:171","msg":"trace[2030181272] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:21; }","duration":"855.508074ms","start":"2026-06-10T08:00:33.105187Z","end":"2026-06-10T08:00:33.960695Z","steps":["trace[2030181272] 'agreement among raft nodes before linearized reading' (duration: 855.399103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.960777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:33.105164Z","time spent":"855.595574ms","remote":"127.0.0.1:52852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-06-10T08:00:33.96035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.912466Z","time spent":"1.047858172s","remote":"127.0.0.1:52746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:00:33.960963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"999.250324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-06-10T08:00:33.960993Z","caller":"traceutil/trace.go:171","msg":"trace[1764825440] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"999.307874ms","start":"2026-06-10T08:00:32.961676Z","end":"2026-06-10T08:00:33.960984Z","steps":["trace[1764825440] 'agreement among raft nodes before linearized reading' (duration: 999.250933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.961017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.961658Z","time spent":"999.353334ms","remote":"127.0.0.1:52698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-10T08:00:33.961147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054912431s","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-06-10T08:00:33.961173Z","caller":"traceutil/trace.go:171","msg":"trace[138139358] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:21; }","duration":"1.054959731s","start":"2026-06-10T08:00:32.906205Z","end":"2026-06-10T08:00:33.961165Z","steps":["trace[138139358] 'agreement among raft nodes before linearized reading' (duration: 1.054917691s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:33.961199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:00:32.906196Z","time spent":"1.054997301s","remote":"127.0.0.1:52930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"info","ts":"2026-06-10T08:00:34.620778Z","caller":"traceutil/trace.go:171","msg":"trace[816019906] transaction","detail":"{read_only:false; response_revision:144; number_of_response:1; }","duration":"208.789964ms","start":"2026-06-10T08:00:34.411956Z","end":"2026-06-10T08:00:34.620746Z","steps":["trace[816019906] 'process raft request' (duration: 199.322741ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:38.058548Z","caller":"traceutil/trace.go:171","msg":"trace[1063559313] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"161.994507ms","start":"2026-06-10T08:00:37.896528Z","end":"2026-06-10T08:00:38.058523Z","steps":["trace[1063559313] 'process raft request' (duration: 161.895606ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:38.131133Z","caller":"traceutil/trace.go:171","msg":"trace[1598972989] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"234.571558ms","start":"2026-06-10T08:00:37.896533Z","end":"2026-06-10T08:00:38.131105Z","steps":["trace[1598972989] 'process raft request' (duration: 234.380837ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:38.13121Z","caller":"traceutil/trace.go:171","msg":"trace[1111971078] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"198.860075ms","start":"2026-06-10T08:00:37.932332Z","end":"2026-06-10T08:00:38.131192Z","steps":["trace[1111971078] 'process raft request' (duration: 198.697924ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:38.131136Z","caller":"traceutil/trace.go:171","msg":"trace[1900172383] linearizableReadLoop","detail":"{readStateIndex:310; appliedIndex:307; }","duration":"217.290015ms","start":"2026-06-10T08:00:37.913817Z","end":"2026-06-10T08:00:38.131108Z","steps":["trace[1900172383] 'read index received' (duration: 144.677234ms)","trace[1900172383] 'applied index is now lower than readState.Index' (duration: 72.611591ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:00:38.131272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.426036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-06-10T08:00:38.131269Z","caller":"traceutil/trace.go:171","msg":"trace[1859636094] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"234.663999ms","start":"2026-06-10T08:00:37.896575Z","end":"2026-06-10T08:00:38.131239Z","steps":["trace[1859636094] 'process raft request' (duration: 234.429198ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:38.131322Z","caller":"traceutil/trace.go:171","msg":"trace[548183637] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:299; }","duration":"217.524827ms","start":"2026-06-10T08:00:37.913785Z","end":"2026-06-10T08:00:38.13131Z","steps":["trace[548183637] 'agreement among raft nodes before linearized reading' (duration: 217.404586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:00:38.131447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.835454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-10T08:00:38.131526Z","caller":"traceutil/trace.go:171","msg":"trace[1321061853] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:299; }","duration":"198.911515ms","start":"2026-06-10T08:00:37.93258Z","end":"2026-06-10T08:00:38.131491Z","steps":["trace[1321061853] 'agreement among raft nodes before linearized reading' (duration: 198.788174ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:38.311745Z","caller":"traceutil/trace.go:171","msg":"trace[246007103] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"102.326044ms","start":"2026-06-10T08:00:38.209384Z","end":"2026-06-10T08:00:38.31171Z","steps":["trace[246007103] 'process raft request' (duration: 39.333215ms)","trace[246007103] 'compare' (duration: 62.679017ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:00:39.687809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.22225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-10T08:00:39.687927Z","caller":"traceutil/trace.go:171","msg":"trace[60898585] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:315; }","duration":"102.378821ms","start":"2026-06-10T08:00:39.585517Z","end":"2026-06-10T08:00:39.687896Z","steps":["trace[60898585] 'range keys from in-memory index tree' (duration: 102.132569ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:40.165327Z","caller":"traceutil/trace.go:171","msg":"trace[897742970] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"232.094291ms","start":"2026-06-10T08:00:39.933195Z","end":"2026-06-10T08:00:40.16529Z","steps":["trace[897742970] 'process raft request' (duration: 162.954318ms)","trace[897742970] 'compare' (duration: 68.891992ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:00:40.698484Z","caller":"traceutil/trace.go:171","msg":"trace[2032354417] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"140.744853ms","start":"2026-06-10T08:00:40.557715Z","end":"2026-06-10T08:00:40.69846Z","steps":["trace[2032354417] 'process raft request' (duration: 137.735233ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:40.702414Z","caller":"traceutil/trace.go:171","msg":"trace[1782407853] linearizableReadLoop","detail":"{readStateIndex:335; appliedIndex:333; }","duration":"119.658378ms","start":"2026-06-10T08:00:40.582731Z","end":"2026-06-10T08:00:40.70239Z","steps":["trace[1782407853] 'read index received' (duration: 112.843284ms)","trace[1782407853] 'applied index is now lower than readState.Index' (duration: 6.814144ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:00:40.702564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.816399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:00:40.702616Z","caller":"traceutil/trace.go:171","msg":"trace[1473331228] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:0; response_revision:323; }","duration":"119.908909ms","start":"2026-06-10T08:00:40.582689Z","end":"2026-06-10T08:00:40.702597Z","steps":["trace[1473331228] 'agreement among raft nodes before linearized reading' (duration: 119.794758ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:40.702701Z","caller":"traceutil/trace.go:171","msg":"trace[407053042] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"142.417824ms","start":"2026-06-10T08:00:40.560091Z","end":"2026-06-10T08:00:40.702509Z","steps":["trace[407053042] 'process raft request' (duration: 142.176592ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:00:45.24849Z","caller":"traceutil/trace.go:171","msg":"trace[271686853] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"116.569246ms","start":"2026-06-10T08:00:45.1319Z","end":"2026-06-10T08:00:45.248469Z","steps":["trace[271686853] 'process raft request' (duration: 116.399955ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:13.148136Z","caller":"traceutil/trace.go:171","msg":"trace[693306764] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"390.798871ms","start":"2026-06-10T08:01:12.757052Z","end":"2026-06-10T08:01:13.147851Z","steps":["trace[693306764] 'process raft request' (duration: 390.636014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:13.148309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.757034Z","time spent":"391.196828ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:01:13.154736Z","caller":"traceutil/trace.go:171","msg":"trace[1244034017] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"381.36645ms","start":"2026-06-10T08:01:12.773342Z","end":"2026-06-10T08:01:13.154708Z","steps":["trace[1244034017] 'process raft request' (duration: 381.028236ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:13.154821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.773321Z","time spent":"381.459165ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:01:13.154925Z","caller":"traceutil/trace.go:171","msg":"trace[1072503195] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"397.851918ms","start":"2026-06-10T08:01:12.757049Z","end":"2026-06-10T08:01:13.154901Z","steps":["trace[1072503195] 'process raft request' (duration: 397.114016ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:13.15498Z","caller":"traceutil/trace.go:171","msg":"trace[25567463] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"397.785755ms","start":"2026-06-10T08:01:12.757184Z","end":"2026-06-10T08:01:13.15497Z","steps":["trace[25567463] 'process raft request' (duration: 397.107015ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:13.154921Z","caller":"traceutil/trace.go:171","msg":"trace[1773615873] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:548; }","duration":"242.969242ms","start":"2026-06-10T08:01:12.911923Z","end":"2026-06-10T08:01:13.154892Z","steps":["trace[1773615873] 'read index received' (duration: 235.712926ms)","trace[1773615873] 'applied index is now lower than readState.Index' (duration: 7.255236ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:01:13.15502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.757028Z","time spent":"397.947132ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:01:13.15503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.757177Z","time spent":"397.828487ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:01:13.155125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.168912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T08:01:13.155133Z","caller":"traceutil/trace.go:171","msg":"trace[784720600] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"380.372366ms","start":"2026-06-10T08:01:12.774742Z","end":"2026-06-10T08:01:13.155114Z","steps":["trace[784720600] 'process raft request' (duration: 379.662945ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:13.155164Z","caller":"traceutil/trace.go:171","msg":"trace[1720344566] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:540; }","duration":"243.281477ms","start":"2026-06-10T08:01:12.911869Z","end":"2026-06-10T08:01:13.155151Z","steps":["trace[1720344566] 'agreement among raft nodes before linearized reading' (duration: 243.154721ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:13.155162Z","caller":"traceutil/trace.go:171","msg":"trace[456249961] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"370.24988ms","start":"2026-06-10T08:01:12.784837Z","end":"2026-06-10T08:01:13.155087Z","steps":["trace[456249961] 'process raft request' (duration: 369.740368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:13.155204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.774731Z","time spent":"380.44484ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:01:13.155334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.78483Z","time spent":"370.414647ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:01:13.155371Z","caller":"traceutil/trace.go:171","msg":"trace[1961188912] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"384.393224ms","start":"2026-06-10T08:01:12.770965Z","end":"2026-06-10T08:01:13.155358Z","steps":["trace[1961188912] 'process raft request' (duration: 383.362919ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:13.155445Z","caller":"traceutil/trace.go:171","msg":"trace[1041001667] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"356.838508ms","start":"2026-06-10T08:01:12.798593Z","end":"2026-06-10T08:01:13.155432Z","steps":["trace[1041001667] 'process raft request' (duration: 356.034283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:13.155457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.770943Z","time spent":"384.485838ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:01:13.155524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.798574Z","time spent":"356.901041ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:01:13.155564Z","caller":"traceutil/trace.go:171","msg":"trace[1908028324] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"209.774228ms","start":"2026-06-10T08:01:12.945772Z","end":"2026-06-10T08:01:13.155546Z","steps":["trace[1908028324] 'process raft request' (duration: 209.053947ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:13.155602Z","caller":"traceutil/trace.go:171","msg":"trace[630321821] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"374.959478ms","start":"2026-06-10T08:01:12.780629Z","end":"2026-06-10T08:01:13.155589Z","steps":["trace[630321821] 'process raft request' (duration: 373.85528ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:13.155648Z","caller":"traceutil/trace.go:171","msg":"trace[1889306649] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"355.06851ms","start":"2026-06-10T08:01:12.80057Z","end":"2026-06-10T08:01:13.155638Z","steps":["trace[1889306649] 'process raft request' (duration: 354.181031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:13.155655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.78062Z","time spent":"375.01273ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:01:13.155691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.800558Z","time spent":"355.110701ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:01:13.155735Z","caller":"traceutil/trace.go:171","msg":"trace[1565467601] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"380.163578ms","start":"2026-06-10T08:01:12.774941Z","end":"2026-06-10T08:01:13.155105Z","steps":["trace[1565467601] 'process raft request' (duration: 379.505769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:13.155774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:12.774933Z","time spent":"380.823186ms","remote":"127.0.0.1:52628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:01:16.490884Z","caller":"traceutil/trace.go:171","msg":"trace[1210007826] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"595.194804ms","start":"2026-06-10T08:01:15.895664Z","end":"2026-06-10T08:01:16.490859Z","steps":["trace[1210007826] 'process raft request' (duration: 579.477233ms)","trace[1210007826] 'compare' (duration: 15.390387ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:01:16.491018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:15.895641Z","time spent":"595.324629ms","remote":"127.0.0.1:52682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1749,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:01:16.498688Z","caller":"traceutil/trace.go:171","msg":"trace[984786131] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"602.595175ms","start":"2026-06-10T08:01:15.896016Z","end":"2026-06-10T08:01:16.498611Z","steps":["trace[984786131] 'process raft request' (duration: 602.278972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:16.499036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:15.895996Z","time spent":"602.789593ms","remote":"127.0.0.1:52776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:01:16.500325Z","caller":"traceutil/trace.go:171","msg":"trace[1855852723] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"214.626729ms","start":"2026-06-10T08:01:16.285664Z","end":"2026-06-10T08:01:16.50029Z","steps":["trace[1855852723] 'process raft request' (duration: 213.880897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:20.490602Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226752844833339,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T08:01:20.533033Z","caller":"traceutil/trace.go:171","msg":"trace[1649227705] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"587.439292ms","start":"2026-06-10T08:01:19.945569Z","end":"2026-06-10T08:01:20.533008Z","steps":["trace[1649227705] 'process raft request' (duration: 586.86969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:20.53317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:19.945535Z","time spent":"587.560718ms","remote":"127.0.0.1:52676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:01:20.704068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.612385ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-10T08:01:20.704182Z","caller":"traceutil/trace.go:171","msg":"trace[1885496808] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:665; }","duration":"714.663198ms","start":"2026-06-10T08:01:19.989495Z","end":"2026-06-10T08:01:20.704158Z","steps":["trace[1885496808] 'read index received' (duration: 542.856383ms)","trace[1885496808] 'applied index is now lower than readState.Index' (duration: 171.804715ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:01:20.704512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.004621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jsz58\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-10T08:01:20.704574Z","caller":"traceutil/trace.go:171","msg":"trace[251589835] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jsz58; range_end:; response_count:1; response_revision:640; }","duration":"715.094225ms","start":"2026-06-10T08:01:19.989463Z","end":"2026-06-10T08:01:20.704557Z","steps":["trace[251589835] 'agreement among raft nodes before linearized reading' (duration: 714.792983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:20.704715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:19.989449Z","time spent":"715.248442ms","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-jsz58\" "} {"level":"warn","ts":"2026-06-10T08:01:21.204279Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226752844833343,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T08:01:21.496566Z","caller":"traceutil/trace.go:171","msg":"trace[2128657528] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"909.143596ms","start":"2026-06-10T08:01:20.587402Z","end":"2026-06-10T08:01:21.496546Z","steps":["trace[2128657528] 'process raft request' (duration: 909.025921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:21.496706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:20.587377Z","time spent":"909.277061ms","remote":"127.0.0.1:52812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:01:22.035842Z","caller":"traceutil/trace.go:171","msg":"trace[1012111902] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"1.331604182s","start":"2026-06-10T08:01:20.704215Z","end":"2026-06-10T08:01:22.035819Z","steps":["trace[1012111902] 'read index received' (duration: 792.220583ms)","trace[1012111902] 'applied index is now lower than readState.Index' (duration: 539.382639ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:01:22.035999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.419150984s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T08:01:22.036034Z","caller":"traceutil/trace.go:171","msg":"trace[292736160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"1.419215297s","start":"2026-06-10T08:01:20.616809Z","end":"2026-06-10T08:01:22.036024Z","steps":["trace[292736160] 'agreement among raft nodes before linearized reading' (duration: 1.419090032s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:22.036058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:20.616798Z","time spent":"1.419254429s","remote":"127.0.0.1:52852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:01:22.036086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.875914ms","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-06-10T08:01:22.036124Z","caller":"traceutil/trace.go:171","msg":"trace[1763403965] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:642; }","duration":"491.948607ms","start":"2026-06-10T08:01:21.544165Z","end":"2026-06-10T08:01:22.036114Z","steps":["trace[1763403965] 'agreement among raft nodes before linearized reading' (duration: 491.859234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:22.036119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.433576153s","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-06-10T08:01:22.036203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.662ms","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-06-10T08:01:22.036207Z","caller":"traceutil/trace.go:171","msg":"trace[1936160901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"1.433700348s","start":"2026-06-10T08:01:20.602486Z","end":"2026-06-10T08:01:22.036186Z","steps":["trace[1936160901] 'agreement among raft nodes before linearized reading' (duration: 1.433446018s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:22.036233Z","caller":"traceutil/trace.go:171","msg":"trace[381520639] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:642; }","duration":"535.730154ms","start":"2026-06-10T08:01:21.500496Z","end":"2026-06-10T08:01:22.036226Z","steps":["trace[381520639] 'agreement among raft nodes before linearized reading' (duration: 535.681022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:22.036253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:20.602477Z","time spent":"1.433768031s","remote":"127.0.0.1:52852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T08:01:22.036263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:21.500478Z","time spent":"535.779495ms","remote":"127.0.0.1:52776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-06-10T08:01:22.036284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.949513ms","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-06-10T08:01:22.036305Z","caller":"traceutil/trace.go:171","msg":"trace[1359853015] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:642; }","duration":"833.004505ms","start":"2026-06-10T08:01:21.203294Z","end":"2026-06-10T08:01:22.036298Z","steps":["trace[1359853015] 'agreement among raft nodes before linearized reading' (duration: 832.945423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:22.036328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:21.203274Z","time spent":"833.049687ms","remote":"127.0.0.1:52852","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-06-10T08:01:22.035998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.291889467s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:01:22.036385Z","caller":"traceutil/trace.go:171","msg":"trace[1505176492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"1.292287183s","start":"2026-06-10T08:01:20.744092Z","end":"2026-06-10T08:01:22.036379Z","steps":["trace[1505176492] 'agreement among raft nodes before linearized reading' (duration: 1.291871566s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:22.036406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:20.744055Z","time spent":"1.292346945s","remote":"127.0.0.1:52562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T08:01:22.036011Z","caller":"traceutil/trace.go:171","msg":"trace[1241449184] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"1.316301017s","start":"2026-06-10T08:01:20.719583Z","end":"2026-06-10T08:01:22.035884Z","steps":["trace[1241449184] 'process raft request' (duration: 1.314281178s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:22.036159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:21.544144Z","time spent":"492.008059ms","remote":"127.0.0.1:52852","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-06-10T08:01:22.036683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:20.719567Z","time spent":"1.316962203s","remote":"127.0.0.1:52758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:01:24.231542Z","caller":"traceutil/trace.go:171","msg":"trace[43031558] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"227.998006ms","start":"2026-06-10T08:01:24.00352Z","end":"2026-06-10T08:01:24.231518Z","steps":["trace[43031558] 'process raft request' (duration: 192.384131ms)","trace[43031558] 'compare' (duration: 35.346134ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:01:24.256767Z","caller":"traceutil/trace.go:171","msg":"trace[765064236] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"244.03132ms","start":"2026-06-10T08:01:24.012714Z","end":"2026-06-10T08:01:24.256745Z","steps":["trace[765064236] 'process raft request' (duration: 243.924596ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:24.256826Z","caller":"traceutil/trace.go:171","msg":"trace[278116842] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"114.996426ms","start":"2026-06-10T08:01:24.141824Z","end":"2026-06-10T08:01:24.25682Z","steps":["trace[278116842] 'process raft request' (duration: 114.8569ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:24.256754Z","caller":"traceutil/trace.go:171","msg":"trace[863052711] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:698; }","duration":"251.054298ms","start":"2026-06-10T08:01:24.005675Z","end":"2026-06-10T08:01:24.256729Z","steps":["trace[863052711] 'read index received' (duration: 190.242888ms)","trace[863052711] 'applied index is now lower than readState.Index' (duration: 60.8105ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:01:24.256783Z","caller":"traceutil/trace.go:171","msg":"trace[2004211946] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"253.094097ms","start":"2026-06-10T08:01:24.003672Z","end":"2026-06-10T08:01:24.256766Z","steps":["trace[2004211946] 'process raft request' (duration: 252.840667ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:24.257114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.416412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-9z522\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-06-10T08:01:24.257167Z","caller":"traceutil/trace.go:171","msg":"trace[2080524838] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-9z522; range_end:; response_count:1; response_revision:675; }","duration":"251.516747ms","start":"2026-06-10T08:01:24.005639Z","end":"2026-06-10T08:01:24.257156Z","steps":["trace[2080524838] 'agreement among raft nodes before linearized reading' (duration: 251.174534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:24.306079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.609139ms","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-06-10T08:01:24.306161Z","caller":"traceutil/trace.go:171","msg":"trace[1863279062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:676; }","duration":"246.742024ms","start":"2026-06-10T08:01:24.059398Z","end":"2026-06-10T08:01:24.30614Z","steps":["trace[1863279062] 'agreement among raft nodes before linearized reading' (duration: 246.471493ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:24.306167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.817886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-10T08:01:24.306076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.914147ms","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-06-10T08:01:24.306233Z","caller":"traceutil/trace.go:171","msg":"trace[118082769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:676; }","duration":"246.912191ms","start":"2026-06-10T08:01:24.059307Z","end":"2026-06-10T08:01:24.306219Z","steps":["trace[118082769] 'agreement among raft nodes before linearized reading' (duration: 246.691532ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:24.306285Z","caller":"traceutil/trace.go:171","msg":"trace[1367430941] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:676; }","duration":"249.135995ms","start":"2026-06-10T08:01:24.0571Z","end":"2026-06-10T08:01:24.306236Z","steps":["trace[1367430941] 'agreement among raft nodes before linearized reading' (duration: 248.74899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:24.306548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.785182ms","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-06-10T08:01:24.306687Z","caller":"traceutil/trace.go:171","msg":"trace[1740024347] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:676; }","duration":"248.965118ms","start":"2026-06-10T08:01:24.057695Z","end":"2026-06-10T08:01:24.30666Z","steps":["trace[1740024347] 'agreement among raft nodes before linearized reading' (duration: 248.393467ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:01:27.289753Z","caller":"traceutil/trace.go:171","msg":"trace[333645681] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"148.752757ms","start":"2026-06-10T08:01:27.140979Z","end":"2026-06-10T08:01:27.289732Z","steps":["trace[333645681] 'process raft request' (duration: 56.147618ms)","trace[333645681] 'compare' (duration: 92.424662ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:01:38.095412Z","caller":"traceutil/trace.go:171","msg":"trace[640802021] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:836; }","duration":"349.149067ms","start":"2026-06-10T08:01:37.746236Z","end":"2026-06-10T08:01:38.095386Z","steps":["trace[640802021] 'read index received' (duration: 348.963951ms)","trace[640802021] 'applied index is now lower than readState.Index' (duration: 184.316µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:01:38.095502Z","caller":"traceutil/trace.go:171","msg":"trace[605318185] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"664.828056ms","start":"2026-06-10T08:01:37.430641Z","end":"2026-06-10T08:01:38.095469Z","steps":["trace[605318185] 'process raft request' (duration: 664.614519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:38.095587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.337203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:01:38.095631Z","caller":"traceutil/trace.go:171","msg":"trace[1788935223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:805; }","duration":"349.429926ms","start":"2026-06-10T08:01:37.746189Z","end":"2026-06-10T08:01:38.095619Z","steps":["trace[1788935223] 'agreement among raft nodes before linearized reading' (duration: 349.350624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:01:38.095665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:37.74617Z","time spent":"349.487499ms","remote":"127.0.0.1:52562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T08:01:38.095692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:01:37.43063Z","time spent":"664.95872ms","remote":"127.0.0.1:52852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:01:38.239721Z","caller":"traceutil/trace.go:171","msg":"trace[365648026] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"135.757011ms","start":"2026-06-10T08:01:38.103948Z","end":"2026-06-10T08:01:38.239705Z","steps":["trace[365648026] 'process raft request' (duration: 135.643197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:02:34.861823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.333673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:02:34.861901Z","caller":"traceutil/trace.go:171","msg":"trace[1583631788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1122; }","duration":"117.454166ms","start":"2026-06-10T08:02:34.74443Z","end":"2026-06-10T08:02:34.861884Z","steps":["trace[1583631788] 'range keys from in-memory index tree' (duration: 117.242602ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:02:36.117205Z","caller":"traceutil/trace.go:171","msg":"trace[1428478206] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"211.927794ms","start":"2026-06-10T08:02:35.905258Z","end":"2026-06-10T08:02:36.117186Z","steps":["trace[1428478206] 'process raft request' (duration: 211.820652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:02:36.536142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.547327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:02:36.536234Z","caller":"traceutil/trace.go:171","msg":"trace[1748906983] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1128; }","duration":"174.691529ms","start":"2026-06-10T08:02:36.361521Z","end":"2026-06-10T08:02:36.536213Z","steps":["trace[1748906983] 'count revisions from in-memory index tree' (duration: 174.467755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:02:37.30729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.362749ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:02:37.307392Z","caller":"traceutil/trace.go:171","msg":"trace[1377956185] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"326.658025ms","start":"2026-06-10T08:02:36.980714Z","end":"2026-06-10T08:02:37.307372Z","steps":["trace[1377956185] 'process raft request' (duration: 140.139604ms)","trace[1377956185] 'compare' (duration: 185.9514ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:02:37.307448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:02:36.980697Z","time spent":"326.724806ms","remote":"127.0.0.1:52852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:02:37.334711Z","caller":"traceutil/trace.go:171","msg":"trace[1161873109] linearizableReadLoop","detail":"{readStateIndex:1178; appliedIndex:1176; }","duration":"316.66932ms","start":"2026-06-10T08:02:37.018012Z","end":"2026-06-10T08:02:37.334681Z","steps":["trace[1161873109] 'read index received' (duration: 102.882654ms)","trace[1161873109] 'applied index is now lower than readState.Index' (duration: 213.785656ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:02:37.334768Z","caller":"traceutil/trace.go:171","msg":"trace[1958172343] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"353.906838ms","start":"2026-06-10T08:02:36.980841Z","end":"2026-06-10T08:02:37.334748Z","steps":["trace[1958172343] 'process raft request' (duration: 353.721305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:02:37.334859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:02:36.980815Z","time spent":"353.99504ms","remote":"127.0.0.1:52852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:02:37.334869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.826353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:02:37.334945Z","caller":"traceutil/trace.go:171","msg":"trace[1423489137] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1133; }","duration":"316.935645ms","start":"2026-06-10T08:02:37.01797Z","end":"2026-06-10T08:02:37.334905Z","steps":["trace[1423489137] 'agreement among raft nodes before linearized reading' (duration: 316.826653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:02:37.335001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:02:37.017951Z","time spent":"317.037017ms","remote":"127.0.0.1:52852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":29,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-06-10T08:02:37.529172Z","caller":"traceutil/trace.go:171","msg":"trace[765533754] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"106.442504ms","start":"2026-06-10T08:02:37.422704Z","end":"2026-06-10T08:02:37.529146Z","steps":["trace[765533754] 'process raft request' (duration: 101.890796ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:02:39.483092Z","caller":"traceutil/trace.go:171","msg":"trace[1573869624] linearizableReadLoop","detail":"{readStateIndex:1184; appliedIndex:1183; }","duration":"144.886303ms","start":"2026-06-10T08:02:39.338184Z","end":"2026-06-10T08:02:39.483071Z","steps":["trace[1573869624] 'read index received' (duration: 144.681469ms)","trace[1573869624] 'applied index is now lower than readState.Index' (duration: 204.094µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:02:39.483264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.057386ms","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-06-10T08:02:39.483296Z","caller":"traceutil/trace.go:171","msg":"trace[581490128] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1139; }","duration":"145.134007ms","start":"2026-06-10T08:02:39.338153Z","end":"2026-06-10T08:02:39.483287Z","steps":["trace[581490128] 'agreement among raft nodes before linearized reading' (duration: 144.996324ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:02:39.483609Z","caller":"traceutil/trace.go:171","msg":"trace[1577729849] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"168.260645ms","start":"2026-06-10T08:02:39.315339Z","end":"2026-06-10T08:02:39.483599Z","steps":["trace[1577729849] 'process raft request' (duration: 167.589502ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:02:41.112914Z","caller":"traceutil/trace.go:171","msg":"trace[2131026723] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"101.370231ms","start":"2026-06-10T08:02:41.01152Z","end":"2026-06-10T08:02:41.11289Z","steps":["trace[2131026723] 'process raft request' (duration: 101.230728ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:02:43.31476Z","caller":"traceutil/trace.go:171","msg":"trace[1110543271] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"192.288398ms","start":"2026-06-10T08:02:43.122443Z","end":"2026-06-10T08:02:43.314731Z","steps":["trace[1110543271] 'process raft request' (duration: 192.087105ms)"],"step_count":1}