{"level":"warn","ts":"2026-10-27T18:51:10.684961Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-27T18:51:10.685084Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.96: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://162.253.55.96:2380","--initial-cluster=instance=https://162.253.55.96:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.96:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.96: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-10-27T18:51:10.685201Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-27T18:51:10.685215Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.96:2380"]} {"level":"info","ts":"2026-10-27T18:51:10.685257Z","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-10-27T18:51:10.685975Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"]} {"level":"info","ts":"2026-10-27T18:51:10.686062Z","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://162.253.55.96:2380"],"listen-peer-urls":["https://162.253.55.96:2380"],"advertise-client-urls":["https://162.253.55.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.96: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-10-27T18:51:10.694496Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.453895ms"} {"level":"info","ts":"2026-10-27T18:51:10.715327Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"64a80de7883e6886","cluster-id":"8160e60c0578d165"} {"level":"info","ts":"2026-10-27T18:51:10.71552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=()"} {"level":"info","ts":"2026-10-27T18:51:10.715594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became follower at term 0"} {"level":"info","ts":"2026-10-27T18:51:10.715614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 64a80de7883e6886 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-27T18:51:10.71563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became follower at term 1"} {"level":"info","ts":"2026-10-27T18:51:10.715674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=(7253062487954581638)"} {"level":"warn","ts":"2026-10-27T18:51:10.72814Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-27T18:51:10.730266Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-27T18:51:10.732419Z","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-10-27T18:51:10.735255Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"64a80de7883e6886","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-27T18:51:10.735948Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"64a80de7883e6886","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-27T18:51:10.736043Z","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-10-27T18:51:10.736113Z","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-10-27T18:51:10.736123Z","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-10-27T18:51:10.74976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=(7253062487954581638)"} {"level":"info","ts":"2026-10-27T18:51:10.749975Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8160e60c0578d165","local-member-id":"64a80de7883e6886","added-peer-id":"64a80de7883e6886","added-peer-peer-urls":["https://162.253.55.96:2380"]} {"level":"info","ts":"2026-10-27T18:51:10.750502Z","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-10-27T18:51:10.750781Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"64a80de7883e6886","initial-advertise-peer-urls":["https://162.253.55.96:2380"],"listen-peer-urls":["https://162.253.55.96:2380"],"advertise-client-urls":["https://162.253.55.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-27T18:51:10.750815Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-27T18:51:10.750949Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.96:2380"} {"level":"info","ts":"2026-10-27T18:51:10.75096Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.96:2380"} {"level":"info","ts":"2026-10-27T18:51:11.117249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 is starting a new election at term 1"} {"level":"info","ts":"2026-10-27T18:51:11.117318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-27T18:51:11.117375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 received MsgPreVoteResp from 64a80de7883e6886 at term 1"} {"level":"info","ts":"2026-10-27T18:51:11.117396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became candidate at term 2"} {"level":"info","ts":"2026-10-27T18:51:11.117405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 received MsgVoteResp from 64a80de7883e6886 at term 2"} {"level":"info","ts":"2026-10-27T18:51:11.117419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became leader at term 2"} {"level":"info","ts":"2026-10-27T18:51:11.117433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 64a80de7883e6886 elected leader 64a80de7883e6886 at term 2"} {"level":"info","ts":"2026-10-27T18:51:11.158319Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-27T18:51:11.190657Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"64a80de7883e6886","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.96:2379]}","request-path":"/0/members/64a80de7883e6886/attributes","cluster-id":"8160e60c0578d165","publish-timeout":"7s"} {"level":"info","ts":"2026-10-27T18:51:11.19068Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-27T18:51:11.190769Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-27T18:51:11.191042Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-27T18:51:11.191113Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-27T18:51:11.194673Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.96:2379"} {"level":"info","ts":"2026-10-27T18:51:11.195527Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-27T18:51:11.202802Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8160e60c0578d165","local-member-id":"64a80de7883e6886","cluster-version":"3.5"} {"level":"info","ts":"2026-10-27T18:51:11.202958Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-27T18:51:11.203111Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} 2026/10/27 18:51:16 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-10-27T18:51:17.705936Z","caller":"traceutil/trace.go:171","msg":"trace[1298681840] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"102.472342ms","start":"2026-10-27T18:51:17.603411Z","end":"2026-10-27T18:51:17.705883Z","steps":["trace[1298681840] 'process raft request' (duration: 52.522643ms)","trace[1298681840] 'compare' (duration: 49.704893ms)"],"step_count":2} {"level":"warn","ts":"2026-10-27T18:51:29.588274Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7531884992377126517,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-27T18:51:29.986899Z","caller":"traceutil/trace.go:171","msg":"trace[270137984] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:398; }","duration":"901.072762ms","start":"2026-10-27T18:51:29.085793Z","end":"2026-10-27T18:51:29.986865Z","steps":["trace[270137984] 'read index received' (duration: 900.879707ms)","trace[270137984] 'applied index is now lower than readState.Index' (duration: 191.435µs)"],"step_count":2} {"level":"info","ts":"2026-10-27T18:51:29.986965Z","caller":"traceutil/trace.go:171","msg":"trace[102615193] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"925.626497ms","start":"2026-10-27T18:51:29.061297Z","end":"2026-10-27T18:51:29.986924Z","steps":["trace[102615193] 'process raft request' (duration: 925.3874ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:29.987202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.35945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-27T18:51:29.987355Z","caller":"traceutil/trace.go:171","msg":"trace[1704085448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:388; }","duration":"901.566905ms","start":"2026-10-27T18:51:29.085762Z","end":"2026-10-27T18:51:29.987329Z","steps":["trace[1704085448] 'agreement among raft nodes before linearized reading' (duration: 901.259367ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:29.987415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:29.085742Z","time spent":"901.662879ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-27T18:51:29.988088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:29.061264Z","time spent":"925.783341ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-27T18:51:30.000452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.687568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-27T18:51:30.000512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.96124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-10-27T18:51:30.000581Z","caller":"traceutil/trace.go:171","msg":"trace[8091977] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:389; }","duration":"731.039981ms","start":"2026-10-27T18:51:29.269506Z","end":"2026-10-27T18:51:30.000546Z","steps":["trace[8091977] 'agreement among raft nodes before linearized reading' (duration: 730.903947ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:51:30.000548Z","caller":"traceutil/trace.go:171","msg":"trace[1260368640] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:389; }","duration":"854.842383ms","start":"2026-10-27T18:51:29.145686Z","end":"2026-10-27T18:51:30.000529Z","steps":["trace[1260368640] 'agreement among raft nodes before linearized reading' (duration: 854.652577ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:30.000649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:29.145657Z","time spent":"854.976107ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-27T18:51:30.001389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:29.269494Z","time spent":"731.856675ms","remote":"127.0.0.1:34986","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":"info","ts":"2026-10-27T18:51:44.867396Z","caller":"traceutil/trace.go:171","msg":"trace[438291254] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"193.59412ms","start":"2026-10-27T18:51:44.673767Z","end":"2026-10-27T18:51:44.867361Z","steps":["trace[438291254] 'process raft request' (duration: 192.895329ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:51:47.030599Z","caller":"traceutil/trace.go:171","msg":"trace[1353153267] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"100.860651ms","start":"2026-10-27T18:51:46.929697Z","end":"2026-10-27T18:51:47.030558Z","steps":["trace[1353153267] 'process raft request' (duration: 100.652235ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:58.675698Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7531884992377126791,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-27T18:51:58.834523Z","caller":"traceutil/trace.go:171","msg":"trace[571745155] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"662.004244ms","start":"2026-10-27T18:51:58.172488Z","end":"2026-10-27T18:51:58.834492Z","steps":["trace[571745155] 'process raft request' (duration: 661.805789ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:58.834722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.172454Z","time spent":"662.144628ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-27T18:51:58.843268Z","caller":"traceutil/trace.go:171","msg":"trace[545839598] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"494.254112ms","start":"2026-10-27T18:51:58.348996Z","end":"2026-10-27T18:51:58.84325Z","steps":["trace[545839598] 'process raft request' (duration: 494.056706ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:51:58.843485Z","caller":"traceutil/trace.go:171","msg":"trace[845322627] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"465.558197ms","start":"2026-10-27T18:51:58.377913Z","end":"2026-10-27T18:51:58.843472Z","steps":["trace[845322627] 'process raft request' (duration: 465.392403ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:51:58.843552Z","caller":"traceutil/trace.go:171","msg":"trace[860539301] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"465.455974ms","start":"2026-10-27T18:51:58.378054Z","end":"2026-10-27T18:51:58.84351Z","steps":["trace[860539301] 'process raft request' (duration: 465.275869ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:51:58.843613Z","caller":"traceutil/trace.go:171","msg":"trace[33582129] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:534; }","duration":"668.759824ms","start":"2026-10-27T18:51:58.174833Z","end":"2026-10-27T18:51:58.843592Z","steps":["trace[33582129] 'read index received' (duration: 659.456599ms)","trace[33582129] 'applied index is now lower than readState.Index' (duration: 9.302345ms)"],"step_count":2} {"level":"info","ts":"2026-10-27T18:51:58.843702Z","caller":"traceutil/trace.go:171","msg":"trace[12986680] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"468.437482ms","start":"2026-10-27T18:51:58.375252Z","end":"2026-10-27T18:51:58.843689Z","steps":["trace[12986680] 'process raft request' (duration: 468.026509ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:51:58.843722Z","caller":"traceutil/trace.go:171","msg":"trace[116478667] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"438.752567ms","start":"2026-10-27T18:51:58.40496Z","end":"2026-10-27T18:51:58.843713Z","steps":["trace[116478667] 'process raft request' (duration: 438.453429ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:51:58.843633Z","caller":"traceutil/trace.go:171","msg":"trace[1554781581] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"461.142537ms","start":"2026-10-27T18:51:58.382375Z","end":"2026-10-27T18:51:58.843517Z","steps":["trace[1554781581] 'process raft request' (duration: 460.981342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:58.843754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.37524Z","time spent":"468.487943ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-27T18:51:58.843769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.378048Z","time spent":"465.606999ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-27T18:51:58.843822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.404949Z","time spent":"438.799518ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-27T18:51:58.843627Z","caller":"traceutil/trace.go:171","msg":"trace[1166113610] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"451.867313ms","start":"2026-10-27T18:51:58.39174Z","end":"2026-10-27T18:51:58.843607Z","steps":["trace[1166113610] 'process raft request' (duration: 451.645197ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:58.843914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.382349Z","time spent":"461.434825ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-27T18:51:58.843985Z","caller":"traceutil/trace.go:171","msg":"trace[175062651] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"425.98711ms","start":"2026-10-27T18:51:58.417992Z","end":"2026-10-27T18:51:58.843979Z","steps":["trace[175062651] 'process raft request' (duration: 425.460565ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:58.844016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.41798Z","time spent":"426.020261ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-27T18:51:58.843296Z","caller":"traceutil/trace.go:171","msg":"trace[268071001] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"484.498335ms","start":"2026-10-27T18:51:58.358776Z","end":"2026-10-27T18:51:58.843275Z","steps":["trace[268071001] 'process raft request' (duration: 484.391642ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:51:58.844081Z","caller":"traceutil/trace.go:171","msg":"trace[1632155843] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"289.111618ms","start":"2026-10-27T18:51:58.554959Z","end":"2026-10-27T18:51:58.844071Z","steps":["trace[1632155843] 'process raft request' (duration: 288.570502ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:51:58.844232Z","caller":"traceutil/trace.go:171","msg":"trace[1339055774] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"484.505755ms","start":"2026-10-27T18:51:58.358914Z","end":"2026-10-27T18:51:58.84342Z","steps":["trace[1339055774] 'process raft request' (duration: 484.274007ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:58.844244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.358729Z","time spent":"485.384751ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-27T18:51:58.843458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.348963Z","time spent":"494.451379ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-27T18:51:58.844274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.477543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-10-27T18:51:58.844041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.205056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-10-27T18:51:58.844425Z","caller":"traceutil/trace.go:171","msg":"trace[111652217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:529; }","duration":"651.619558ms","start":"2026-10-27T18:51:58.192738Z","end":"2026-10-27T18:51:58.844357Z","steps":["trace[111652217] 'agreement among raft nodes before linearized reading' (duration: 651.242877ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:58.843634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.377885Z","time spent":"465.649479ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-27T18:51:58.843364Z","caller":"traceutil/trace.go:171","msg":"trace[1871485531] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"468.262957ms","start":"2026-10-27T18:51:58.375086Z","end":"2026-10-27T18:51:58.843349Z","steps":["trace[1871485531] 'process raft request' (duration: 468.163423ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:51:58.844551Z","caller":"traceutil/trace.go:171","msg":"trace[1464383343] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:529; }","duration":"669.647399ms","start":"2026-10-27T18:51:58.17482Z","end":"2026-10-27T18:51:58.844467Z","steps":["trace[1464383343] 'agreement among raft nodes before linearized reading' (duration: 669.113354ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:51:58.844538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.192726Z","time spent":"651.798133ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-27T18:51:58.844739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.375048Z","time spent":"469.665318ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-27T18:51:58.844755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.174762Z","time spent":"669.97749ms","remote":"127.0.0.1:34986","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-10-27T18:51:58.84512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.391728Z","time spent":"452.209623ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-27T18:51:58.845453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:58.358903Z","time spent":"485.599006ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-27T18:52:00.268285Z","caller":"traceutil/trace.go:171","msg":"trace[1791389069] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"222.410216ms","start":"2026-10-27T18:52:00.045849Z","end":"2026-10-27T18:52:00.268259Z","steps":["trace[1791389069] 'read index received' (duration: 222.372575ms)","trace[1791389069] 'applied index is now lower than readState.Index' (duration: 36.321µs)"],"step_count":2} {"level":"info","ts":"2026-10-27T18:52:00.268402Z","caller":"traceutil/trace.go:171","msg":"trace[727588750] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"363.425832ms","start":"2026-10-27T18:51:59.904965Z","end":"2026-10-27T18:52:00.268391Z","steps":["trace[727588750] 'process raft request' (duration: 363.087003ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:00.268495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:51:59.904941Z","time spent":"363.484393ms","remote":"127.0.0.1:34760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-27T18:52:00.268861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.002414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570096"} {"level":"info","ts":"2026-10-27T18:52:00.268895Z","caller":"traceutil/trace.go:171","msg":"trace[929663830] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:591; }","duration":"223.086747ms","start":"2026-10-27T18:52:00.045797Z","end":"2026-10-27T18:52:00.268884Z","steps":["trace[929663830] 'agreement among raft nodes before linearized reading' (duration: 222.828789ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:00.287148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.565072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-27T18:52:00.287173Z","caller":"traceutil/trace.go:171","msg":"trace[1886005373] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"223.88911ms","start":"2026-10-27T18:52:00.063254Z","end":"2026-10-27T18:52:00.287143Z","steps":["trace[1886005373] 'process raft request' (duration: 223.397585ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:52:00.28723Z","caller":"traceutil/trace.go:171","msg":"trace[735323403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"142.697426ms","start":"2026-10-27T18:52:00.144512Z","end":"2026-10-27T18:52:00.287209Z","steps":["trace[735323403] 'agreement among raft nodes before linearized reading' (duration: 142.537812ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:52:05.078449Z","caller":"traceutil/trace.go:171","msg":"trace[954985241] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"152.734617ms","start":"2026-10-27T18:52:04.92569Z","end":"2026-10-27T18:52:05.078425Z","steps":["trace[954985241] 'read index received' (duration: 152.655995ms)","trace[954985241] 'applied index is now lower than readState.Index' (duration: 77.202µs)"],"step_count":2} {"level":"info","ts":"2026-10-27T18:52:05.078518Z","caller":"traceutil/trace.go:171","msg":"trace[1784089538] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"209.721299ms","start":"2026-10-27T18:52:04.868764Z","end":"2026-10-27T18:52:05.078485Z","steps":["trace[1784089538] 'process raft request' (duration: 209.485652ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:05.078959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.237502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-27T18:52:05.079035Z","caller":"traceutil/trace.go:171","msg":"trace[1145275196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:621; }","duration":"153.359315ms","start":"2026-10-27T18:52:04.925646Z","end":"2026-10-27T18:52:05.079005Z","steps":["trace[1145275196] 'agreement among raft nodes before linearized reading' (duration: 152.907382ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:52:05.324852Z","caller":"traceutil/trace.go:171","msg":"trace[1353702577] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"246.30636ms","start":"2026-10-27T18:52:05.078521Z","end":"2026-10-27T18:52:05.324827Z","steps":["trace[1353702577] 'read index received' (duration: 245.752543ms)","trace[1353702577] 'applied index is now lower than readState.Index' (duration: 552.867µs)"],"step_count":2} {"level":"info","ts":"2026-10-27T18:52:05.324959Z","caller":"traceutil/trace.go:171","msg":"trace[655934930] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"276.968445ms","start":"2026-10-27T18:52:05.047962Z","end":"2026-10-27T18:52:05.324931Z","steps":["trace[655934930] 'process raft request' (duration: 276.419458ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:05.325065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.482802ms","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-10-27T18:52:05.325094Z","caller":"traceutil/trace.go:171","msg":"trace[1394188834] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"396.552984ms","start":"2026-10-27T18:52:04.928532Z","end":"2026-10-27T18:52:05.325085Z","steps":["trace[1394188834] 'agreement among raft nodes before linearized reading' (duration: 396.404589ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:05.325117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:04.928486Z","time spent":"396.625575ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-27T18:52:05.33487Z","caller":"traceutil/trace.go:171","msg":"trace[505772964] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"251.929956ms","start":"2026-10-27T18:52:05.08289Z","end":"2026-10-27T18:52:05.33482Z","steps":["trace[505772964] 'process raft request' (duration: 251.674338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:05.335314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.043372ms","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-10-27T18:52:05.335436Z","caller":"traceutil/trace.go:171","msg":"trace[1515700311] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"165.525056ms","start":"2026-10-27T18:52:05.169844Z","end":"2026-10-27T18:52:05.335369Z","steps":["trace[1515700311] 'agreement among raft nodes before linearized reading' (duration: 164.944369ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:05.870585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.287856ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-27T18:52:05.870883Z","caller":"traceutil/trace.go:171","msg":"trace[423638519] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"531.088536ms","start":"2026-10-27T18:52:05.339745Z","end":"2026-10-27T18:52:05.870834Z","steps":["trace[423638519] 'process raft request' (duration: 91.217342ms)","trace[423638519] 'compare' (duration: 439.103481ms)"],"step_count":2} {"level":"info","ts":"2026-10-27T18:52:05.87099Z","caller":"traceutil/trace.go:171","msg":"trace[2032806612] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:649; }","duration":"274.513563ms","start":"2026-10-27T18:52:05.596449Z","end":"2026-10-27T18:52:05.870963Z","steps":["trace[2032806612] 'read index received' (duration: 241.359224ms)","trace[2032806612] 'applied index is now lower than readState.Index' (duration: 33.150468ms)"],"step_count":2} {"level":"warn","ts":"2026-10-27T18:52:05.871142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:05.339695Z","time spent":"531.295662ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-27T18:52:05.871223Z","caller":"traceutil/trace.go:171","msg":"trace[1570619298] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"463.11007ms","start":"2026-10-27T18:52:05.408066Z","end":"2026-10-27T18:52:05.871176Z","steps":["trace[1570619298] 'process raft request' (duration: 462.674527ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:05.871382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:05.408034Z","time spent":"463.266533ms","remote":"127.0.0.1:35066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-27T18:52:05.87145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.953805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mmcrj\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-27T18:52:05.871508Z","caller":"traceutil/trace.go:171","msg":"trace[968267702] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mmcrj; range_end:; response_count:1; response_revision:626; }","duration":"275.098179ms","start":"2026-10-27T18:52:05.596394Z","end":"2026-10-27T18:52:05.871492Z","steps":["trace[968267702] 'agreement among raft nodes before linearized reading' (duration: 274.79166ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:06.646451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7531884992377126982,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-27T18:52:07.465745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.506933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-27T18:52:07.465868Z","caller":"traceutil/trace.go:171","msg":"trace[754484471] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.574920729s","start":"2026-10-27T18:52:05.890926Z","end":"2026-10-27T18:52:07.465847Z","steps":["trace[754484471] 'process raft request' (duration: 913.20172ms)","trace[754484471] 'compare' (duration: 661.341049ms)"],"step_count":2} {"level":"warn","ts":"2026-10-27T18:52:07.465928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:05.890895Z","time spent":"1.575005831s","remote":"127.0.0.1:34908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-27T18:52:07.469909Z","caller":"traceutil/trace.go:171","msg":"trace[542559295] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"1.324409434s","start":"2026-10-27T18:52:06.145435Z","end":"2026-10-27T18:52:07.469845Z","steps":["trace[542559295] 'read index received' (duration: 658.379137ms)","trace[542559295] 'applied index is now lower than readState.Index' (duration: 666.028917ms)"],"step_count":2} {"level":"info","ts":"2026-10-27T18:52:07.469988Z","caller":"traceutil/trace.go:171","msg":"trace[1903130070] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.178011323s","start":"2026-10-27T18:52:06.291935Z","end":"2026-10-27T18:52:07.469946Z","steps":["trace[1903130070] 'process raft request' (duration: 1.177190988s)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:07.470109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.324659751s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-27T18:52:07.470176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:06.291907Z","time spent":"1.178162107s","remote":"127.0.0.1:34800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-27T18:52:07.470237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.041591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-27T18:52:07.470238Z","caller":"traceutil/trace.go:171","msg":"trace[440384068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"1.324814445s","start":"2026-10-27T18:52:06.145398Z","end":"2026-10-27T18:52:07.470212Z","steps":["trace[440384068] 'agreement among raft nodes before linearized reading' (duration: 1.324603159s)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:52:07.470297Z","caller":"traceutil/trace.go:171","msg":"trace[2070657326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:628; }","duration":"131.204225ms","start":"2026-10-27T18:52:07.339072Z","end":"2026-10-27T18:52:07.470277Z","steps":["trace[2070657326] 'agreement among raft nodes before linearized reading' (duration: 131.005829ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:07.470197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.34898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-27T18:52:07.47033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:06.145373Z","time spent":"1.324944849s","remote":"127.0.0.1:34696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-27T18:52:07.470448Z","caller":"traceutil/trace.go:171","msg":"trace[1392056913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:628; }","duration":"385.669869ms","start":"2026-10-27T18:52:07.084764Z","end":"2026-10-27T18:52:07.470434Z","steps":["trace[1392056913] 'agreement among raft nodes before linearized reading' (duration: 385.274577ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:07.470492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:07.084685Z","time spent":"385.793752ms","remote":"127.0.0.1:34986","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-10-27T18:52:07.470945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.633424ms","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-10-27T18:52:07.471011Z","caller":"traceutil/trace.go:171","msg":"trace[576529354] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:628; }","duration":"117.741587ms","start":"2026-10-27T18:52:07.353251Z","end":"2026-10-27T18:52:07.470993Z","steps":["trace[576529354] 'agreement among raft nodes before linearized reading' (duration: 117.573062ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:52:09.07551Z","caller":"traceutil/trace.go:171","msg":"trace[924341095] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"121.294383ms","start":"2026-10-27T18:52:08.954192Z","end":"2026-10-27T18:52:09.075486Z","steps":["trace[924341095] 'process raft request' (duration: 121.084517ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:52:16.981765Z","caller":"traceutil/trace.go:171","msg":"trace[1252089596] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"108.014935ms","start":"2026-10-27T18:52:16.873721Z","end":"2026-10-27T18:52:16.981736Z","steps":["trace[1252089596] 'process raft request' (duration: 107.82422ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:52:20.290677Z","caller":"traceutil/trace.go:171","msg":"trace[444156619] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"146.862228ms","start":"2026-10-27T18:52:20.143786Z","end":"2026-10-27T18:52:20.290648Z","steps":["trace[444156619] 'read index received' (duration: 146.640792ms)","trace[444156619] 'applied index is now lower than readState.Index' (duration: 220.306µs)"],"step_count":2} {"level":"info","ts":"2026-10-27T18:52:20.290732Z","caller":"traceutil/trace.go:171","msg":"trace[1253609921] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"251.659192ms","start":"2026-10-27T18:52:20.039028Z","end":"2026-10-27T18:52:20.290687Z","steps":["trace[1253609921] 'process raft request' (duration: 251.408014ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:20.290891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.074715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-27T18:52:20.291002Z","caller":"traceutil/trace.go:171","msg":"trace[932678414] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:779; }","duration":"147.231331ms","start":"2026-10-27T18:52:20.14374Z","end":"2026-10-27T18:52:20.290971Z","steps":["trace[932678414] 'agreement among raft nodes before linearized reading' (duration: 146.999523ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:52:23.781566Z","caller":"traceutil/trace.go:171","msg":"trace[1074532841] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"172.040627ms","start":"2026-10-27T18:52:23.609503Z","end":"2026-10-27T18:52:23.781544Z","steps":["trace[1074532841] 'read index received' (duration: 171.864622ms)","trace[1074532841] 'applied index is now lower than readState.Index' (duration: 174.875µs)"],"step_count":2} {"level":"info","ts":"2026-10-27T18:52:23.781661Z","caller":"traceutil/trace.go:171","msg":"trace[975738336] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"198.82103ms","start":"2026-10-27T18:52:23.582797Z","end":"2026-10-27T18:52:23.781618Z","steps":["trace[975738336] 'process raft request' (duration: 198.576163ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:23.781817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.301715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-27T18:52:23.78188Z","caller":"traceutil/trace.go:171","msg":"trace[1230296336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"172.414209ms","start":"2026-10-27T18:52:23.609455Z","end":"2026-10-27T18:52:23.78187Z","steps":["trace[1230296336] 'agreement among raft nodes before linearized reading' (duration: 172.249434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:23.782058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.830006ms","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-10-27T18:52:23.78218Z","caller":"traceutil/trace.go:171","msg":"trace[1568867059] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:794; }","duration":"103.987771ms","start":"2026-10-27T18:52:23.67817Z","end":"2026-10-27T18:52:23.782157Z","steps":["trace[1568867059] 'agreement among raft nodes before linearized reading' (duration: 103.628561ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:24.512319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.027018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-27T18:52:24.512464Z","caller":"traceutil/trace.go:171","msg":"trace[587000945] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"725.090647ms","start":"2026-10-27T18:52:23.787351Z","end":"2026-10-27T18:52:24.512441Z","steps":["trace[587000945] 'process raft request' (duration: 171.80371ms)","trace[587000945] 'compare' (duration: 552.816482ms)"],"step_count":2} {"level":"warn","ts":"2026-10-27T18:52:24.512533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:23.787322Z","time spent":"725.177128ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-27T18:52:24.591792Z","caller":"traceutil/trace.go:171","msg":"trace[734323089] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"803.860611ms","start":"2026-10-27T18:52:23.787904Z","end":"2026-10-27T18:52:24.591765Z","steps":["trace[734323089] 'process raft request' (duration: 803.642944ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:24.59198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:23.787829Z","time spent":"804.062106ms","remote":"127.0.0.1:34986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-27T18:52:24.591992Z","caller":"traceutil/trace.go:171","msg":"trace[790018826] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:824; }","duration":"708.417153ms","start":"2026-10-27T18:52:23.883542Z","end":"2026-10-27T18:52:24.591959Z","steps":["trace[790018826] 'read index received' (duration: 75.628642ms)","trace[790018826] 'applied index is now lower than readState.Index' (duration: 632.785881ms)"],"step_count":2} {"level":"warn","ts":"2026-10-27T18:52:24.592306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.864943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-27T18:52:24.592288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.723633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-27T18:52:24.592347Z","caller":"traceutil/trace.go:171","msg":"trace[280243293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"443.979747ms","start":"2026-10-27T18:52:24.148355Z","end":"2026-10-27T18:52:24.592335Z","steps":["trace[280243293] 'agreement among raft nodes before linearized reading' (duration: 443.779911ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:52:24.592372Z","caller":"traceutil/trace.go:171","msg":"trace[1261194738] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:797; }","duration":"708.862627ms","start":"2026-10-27T18:52:23.883484Z","end":"2026-10-27T18:52:24.592347Z","steps":["trace[1261194738] 'agreement among raft nodes before linearized reading' (duration: 708.63454ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:24.592384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:24.148324Z","time spent":"444.052018ms","remote":"127.0.0.1:34696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-27T18:52:24.59243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:23.883463Z","time spent":"708.95607ms","remote":"127.0.0.1:35206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":78,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-10-27T18:52:24.592327Z","caller":"traceutil/trace.go:171","msg":"trace[1417012538] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"801.201302ms","start":"2026-10-27T18:52:23.790916Z","end":"2026-10-27T18:52:24.592117Z","steps":["trace[1417012538] 'process raft request' (duration: 800.789429ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:24.592445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.18923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-27T18:52:24.592974Z","caller":"traceutil/trace.go:171","msg":"trace[1336505545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"287.802248ms","start":"2026-10-27T18:52:24.305158Z","end":"2026-10-27T18:52:24.59296Z","steps":["trace[1336505545] 'agreement among raft nodes before linearized reading' (duration: 287.037296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-27T18:52:24.592975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-27T18:52:23.790902Z","time spent":"801.730678ms","remote":"127.0.0.1:34908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-27T18:53:13.76873Z","caller":"traceutil/trace.go:171","msg":"trace[887293880] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"152.14713ms","start":"2026-10-27T18:53:13.616557Z","end":"2026-10-27T18:53:13.768705Z","steps":["trace[887293880] 'process raft request' (duration: 151.988988ms)"],"step_count":1} {"level":"info","ts":"2026-10-27T18:53:57.140376Z","caller":"traceutil/trace.go:171","msg":"trace[1697269774] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"115.937126ms","start":"2026-10-27T18:53:57.024148Z","end":"2026-10-27T18:53:57.140085Z","steps":["trace[1697269774] 'process raft request' (duration: 115.741373ms)"],"step_count":1}