{"level":"warn","ts":"2026-09-18T05:08:33.988625Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T05:08:33.988701Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.121: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.121:2380","--initial-cluster=instance=https://162.253.55.121:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.121:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.121: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-09-18T05:08:33.988753Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T05:08:33.988762Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.121:2380"]} {"level":"info","ts":"2026-09-18T05:08:33.988779Z","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-09-18T05:08:33.98937Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.121:2379"]} {"level":"info","ts":"2026-09-18T05:08:33.989436Z","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.121:2380"],"listen-peer-urls":["https://162.253.55.121:2380"],"advertise-client-urls":["https://162.253.55.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.121: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-09-18T05:08:34.026224Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"20.314566ms"} {"level":"info","ts":"2026-09-18T05:08:34.047369Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e064f6438c9a029d","cluster-id":"46d59d02273d6950"} {"level":"info","ts":"2026-09-18T05:08:34.047437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T05:08:34.047452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became follower at term 0"} {"level":"info","ts":"2026-09-18T05:08:34.047463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e064f6438c9a029d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T05:08:34.047473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became follower at term 1"} {"level":"info","ts":"2026-09-18T05:08:34.047504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d switched to configuration voters=(16169319332149068445)"} {"level":"warn","ts":"2026-09-18T05:08:34.060499Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T05:08:34.062048Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T05:08:34.068316Z","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-09-18T05:08:34.070337Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e064f6438c9a029d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T05:08:34.07381Z","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-09-18T05:08:34.073879Z","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-09-18T05:08:34.073903Z","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-09-18T05:08:34.074148Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e064f6438c9a029d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T05:08:34.076632Z","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-09-18T05:08:34.076869Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e064f6438c9a029d","initial-advertise-peer-urls":["https://162.253.55.121:2380"],"listen-peer-urls":["https://162.253.55.121:2380"],"advertise-client-urls":["https://162.253.55.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T05:08:34.076906Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T05:08:34.077011Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.121:2380"} {"level":"info","ts":"2026-09-18T05:08:34.077033Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.121:2380"} {"level":"info","ts":"2026-09-18T05:08:34.078945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d switched to configuration voters=(16169319332149068445)"} {"level":"info","ts":"2026-09-18T05:08:34.079095Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"46d59d02273d6950","local-member-id":"e064f6438c9a029d","added-peer-id":"e064f6438c9a029d","added-peer-peer-urls":["https://162.253.55.121:2380"]} {"level":"info","ts":"2026-09-18T05:08:35.048399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T05:08:35.048513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T05:08:35.048564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d received MsgPreVoteResp from e064f6438c9a029d at term 1"} {"level":"info","ts":"2026-09-18T05:08:35.048599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became candidate at term 2"} {"level":"info","ts":"2026-09-18T05:08:35.048619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d received MsgVoteResp from e064f6438c9a029d at term 2"} {"level":"info","ts":"2026-09-18T05:08:35.04864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became leader at term 2"} {"level":"info","ts":"2026-09-18T05:08:35.04866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e064f6438c9a029d elected leader e064f6438c9a029d at term 2"} {"level":"info","ts":"2026-09-18T05:08:35.050801Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:08:35.051846Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e064f6438c9a029d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.121:2379]}","request-path":"/0/members/e064f6438c9a029d/attributes","cluster-id":"46d59d02273d6950","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T05:08:35.05185Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T05:08:35.052042Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T05:08:35.05244Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T05:08:35.052462Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T05:08:35.052585Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"46d59d02273d6950","local-member-id":"e064f6438c9a029d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:08:35.05266Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:08:35.052694Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:08:35.053911Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.121:2379"} {"level":"info","ts":"2026-09-18T05:08:35.054794Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T05:08:36.4777Z","caller":"traceutil/trace.go:171","msg":"trace[1273066709] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"124.018527ms","start":"2026-09-18T05:08:36.353662Z","end":"2026-09-18T05:08:36.477681Z","steps":["trace[1273066709] 'read index received' (duration: 123.921674ms)","trace[1273066709] 'applied index is now lower than readState.Index' (duration: 95.963µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:08:36.477839Z","caller":"traceutil/trace.go:171","msg":"trace[425058559] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"125.336779ms","start":"2026-09-18T05:08:36.352425Z","end":"2026-09-18T05:08:36.477761Z","steps":["trace[425058559] 'process raft request' (duration: 125.080842ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:36.477902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.192991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T05:08:36.47797Z","caller":"traceutil/trace.go:171","msg":"trace[390211574] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:2; }","duration":"124.311064ms","start":"2026-09-18T05:08:36.35365Z","end":"2026-09-18T05:08:36.477961Z","steps":["trace[390211574] 'agreement among raft nodes before linearized reading' (duration: 124.136499ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:36.969746Z","caller":"traceutil/trace.go:171","msg":"trace[1621793167] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"539.48487ms","start":"2026-09-18T05:08:36.430215Z","end":"2026-09-18T05:08:36.9697Z","steps":["trace[1621793167] 'process raft request' (duration: 537.886351ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:36.970294Z","caller":"traceutil/trace.go:171","msg":"trace[384738687] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"529.82833ms","start":"2026-09-18T05:08:36.440407Z","end":"2026-09-18T05:08:36.970236Z","steps":["trace[384738687] 'process raft request' (duration: 527.907211ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:36.970899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.430206Z","time spent":"539.617103ms","remote":"127.0.0.1:57510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T05:08:36.971534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.440382Z","time spent":"530.080296ms","remote":"127.0.0.1:57250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T05:08:36.972152Z","caller":"traceutil/trace.go:171","msg":"trace[1055306619] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:5; }","duration":"494.296209ms","start":"2026-09-18T05:08:36.477768Z","end":"2026-09-18T05:08:36.972064Z","steps":["trace[1055306619] 'read index received' (duration: 490.521305ms)","trace[1055306619] 'applied index is now lower than readState.Index' (duration: 3.754393ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:08:36.972173Z","caller":"traceutil/trace.go:171","msg":"trace[1785228497] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"523.438349ms","start":"2026-09-18T05:08:36.448699Z","end":"2026-09-18T05:08:36.972137Z","steps":["trace[1785228497] 'process raft request' (duration: 519.654514ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:36.972308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.448683Z","time spent":"523.541192ms","remote":"127.0.0.1:57304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T05:08:36.973308Z","caller":"traceutil/trace.go:171","msg":"trace[296783991] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"522.132697ms","start":"2026-09-18T05:08:36.450859Z","end":"2026-09-18T05:08:36.972991Z","steps":["trace[296783991] 'process raft request' (duration: 517.551572ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:36.973464Z","caller":"traceutil/trace.go:171","msg":"trace[1214853626] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"522.703361ms","start":"2026-09-18T05:08:36.450686Z","end":"2026-09-18T05:08:36.973389Z","steps":["trace[1214853626] 'process raft request' (duration: 517.692185ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:36.973626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.450822Z","time spent":"522.698241ms","remote":"127.0.0.1:57600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T05:08:36.973663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.450674Z","time spent":"522.880446ms","remote":"127.0.0.1:57600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T05:08:36.974246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.586644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.121\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T05:08:36.974286Z","caller":"traceutil/trace.go:171","msg":"trace[670959954] range","detail":"{range_begin:/registry/masterleases/162.253.55.121; range_end:; response_count:0; response_revision:9; }","duration":"545.670017ms","start":"2026-09-18T05:08:36.428605Z","end":"2026-09-18T05:08:36.974275Z","steps":["trace[670959954] 'agreement among raft nodes before linearized reading' (duration: 544.849676ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:36.974315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.428599Z","time spent":"545.711237ms","remote":"127.0.0.1:57110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/162.253.55.121\" "} {"level":"warn","ts":"2026-09-18T05:08:36.974386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.701006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T05:08:36.974456Z","caller":"traceutil/trace.go:171","msg":"trace[883227449] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:9; }","duration":"620.790168ms","start":"2026-09-18T05:08:36.353635Z","end":"2026-09-18T05:08:36.974425Z","steps":["trace[883227449] 'agreement among raft nodes before linearized reading' (duration: 620.684186ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:36.974501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.353611Z","time spent":"620.87866ms","remote":"127.0.0.1:57144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-09-18T05:08:36.974647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.548608ms","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-09-18T05:08:36.974513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.487966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-18T05:08:36.974742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.53583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-18T05:08:36.974701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.251317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-18T05:08:36.974782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.364739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T05:08:36.974812Z","caller":"traceutil/trace.go:171","msg":"trace[2108331894] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"569.39177ms","start":"2026-09-18T05:08:36.405406Z","end":"2026-09-18T05:08:36.974798Z","steps":["trace[2108331894] 'agreement among raft nodes before linearized reading' (duration: 569.357199ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:36.97483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.4054Z","time spent":"569.426011ms","remote":"127.0.0.1:57192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-09-18T05:08:36.974913Z","caller":"traceutil/trace.go:171","msg":"trace[1359969999] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:9; }","duration":"544.712582ms","start":"2026-09-18T05:08:36.430028Z","end":"2026-09-18T05:08:36.97474Z","steps":["trace[1359969999] 'agreement among raft nodes before linearized reading' (duration: 544.445485ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:36.975005Z","caller":"traceutil/trace.go:171","msg":"trace[1236226938] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"544.743762ms","start":"2026-09-18T05:08:36.430012Z","end":"2026-09-18T05:08:36.974756Z","steps":["trace[1236226938] 'agreement among raft nodes before linearized reading' (duration: 544.481186ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:36.975045Z","caller":"traceutil/trace.go:171","msg":"trace[2096508880] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"610.598302ms","start":"2026-09-18T05:08:36.364162Z","end":"2026-09-18T05:08:36.97476Z","steps":["trace[2096508880] 'agreement among raft nodes before linearized reading' (duration: 610.553901ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:36.97508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.430007Z","time spent":"545.04114ms","remote":"127.0.0.1:57192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-18T05:08:36.975018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.430018Z","time spent":"544.979068ms","remote":"127.0.0.1:57164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-09-18T05:08:36.972423Z","caller":"traceutil/trace.go:171","msg":"trace[319267075] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"520.453365ms","start":"2026-09-18T05:08:36.451406Z","end":"2026-09-18T05:08:36.971859Z","steps":["trace[319267075] 'process raft request' (duration: 517.05051ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:36.974948Z","caller":"traceutil/trace.go:171","msg":"trace[2082671372] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"523.440039ms","start":"2026-09-18T05:08:36.451499Z","end":"2026-09-18T05:08:36.974939Z","steps":["trace[2082671372] 'process raft request' (duration: 520.432664ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:36.975218Z","caller":"traceutil/trace.go:171","msg":"trace[1392630643] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"569.347499ms","start":"2026-09-18T05:08:36.405426Z","end":"2026-09-18T05:08:36.974774Z","steps":["trace[1392630643] 'agreement among raft nodes before linearized reading' (duration: 568.078027ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:36.975267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.451399Z","time spent":"523.812399ms","remote":"127.0.0.1:57600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T05:08:36.975298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.405424Z","time spent":"569.835401ms","remote":"127.0.0.1:57192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-18T05:08:36.975306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.451483Z","time spent":"523.777108ms","remote":"127.0.0.1:57600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T05:08:36.975151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.36415Z","time spent":"610.929221ms","remote":"127.0.0.1:57444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-09-18T05:08:37.277584Z","caller":"traceutil/trace.go:171","msg":"trace[1456801043] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"796.202846ms","start":"2026-09-18T05:08:36.481349Z","end":"2026-09-18T05:08:37.277552Z","steps":["trace[1456801043] 'process raft request' (duration: 796.093503ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:37.277606Z","caller":"traceutil/trace.go:171","msg":"trace[470831686] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"798.382491ms","start":"2026-09-18T05:08:36.479198Z","end":"2026-09-18T05:08:37.27758Z","steps":["trace[470831686] 'process raft request' (duration: 790.897305ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.277741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.481331Z","time spent":"796.348499ms","remote":"127.0.0.1:57600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T05:08:37.277921Z","caller":"traceutil/trace.go:171","msg":"trace[19551705] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"289.28468ms","start":"2026-09-18T05:08:36.98862Z","end":"2026-09-18T05:08:37.277905Z","steps":["trace[19551705] 'process raft request' (duration: 289.195398ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:37.277892Z","caller":"traceutil/trace.go:171","msg":"trace[143970670] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"296.967452ms","start":"2026-09-18T05:08:36.980797Z","end":"2026-09-18T05:08:37.277764Z","steps":["trace[143970670] 'process raft request' (duration: 296.709546ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:37.278275Z","caller":"traceutil/trace.go:171","msg":"trace[1049989415] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"301.217218ms","start":"2026-09-18T05:08:36.977046Z","end":"2026-09-18T05:08:37.278263Z","steps":["trace[1049989415] 'process raft request' (duration: 300.437329ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:37.278348Z","caller":"traceutil/trace.go:171","msg":"trace[1643401874] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:12; }","duration":"306.143073ms","start":"2026-09-18T05:08:36.972197Z","end":"2026-09-18T05:08:37.27834Z","steps":["trace[1643401874] 'read index received' (duration: 297.98635ms)","trace[1643401874] 'applied index is now lower than readState.Index' (duration: 8.155943ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:08:37.278362Z","caller":"traceutil/trace.go:171","msg":"trace[1074724617] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"297.327132ms","start":"2026-09-18T05:08:36.981018Z","end":"2026-09-18T05:08:37.278345Z","steps":["trace[1074724617] 'process raft request' (duration: 296.520422ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.278467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.813466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-09-18T05:08:37.279092Z","caller":"traceutil/trace.go:171","msg":"trace[1176351986] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"786.471211ms","start":"2026-09-18T05:08:36.492606Z","end":"2026-09-18T05:08:37.279077Z","steps":["trace[1176351986] 'agreement among raft nodes before linearized reading' (duration: 785.786035ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.279172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.492591Z","time spent":"786.565974ms","remote":"127.0.0.1:57192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-09-18T05:08:37.278545Z","caller":"traceutil/trace.go:171","msg":"trace[573197092] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"297.010303ms","start":"2026-09-18T05:08:36.981521Z","end":"2026-09-18T05:08:37.278531Z","steps":["trace[573197092] 'process raft request' (duration: 296.049039ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:37.278582Z","caller":"traceutil/trace.go:171","msg":"trace[1090871237] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"296.917511ms","start":"2026-09-18T05:08:36.981654Z","end":"2026-09-18T05:08:37.278572Z","steps":["trace[1090871237] 'process raft request' (duration: 295.963937ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.278675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.216385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T05:08:37.279659Z","caller":"traceutil/trace.go:171","msg":"trace[460510203] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"297.68217ms","start":"2026-09-18T05:08:36.981957Z","end":"2026-09-18T05:08:37.27964Z","steps":["trace[460510203] 'process raft request' (duration: 295.717221ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:37.279684Z","caller":"traceutil/trace.go:171","msg":"trace[141950906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"301.27001ms","start":"2026-09-18T05:08:36.978397Z","end":"2026-09-18T05:08:37.279667Z","steps":["trace[141950906] 'agreement among raft nodes before linearized reading' (duration: 300.220264ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.279739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.978315Z","time spent":"301.409653ms","remote":"127.0.0.1:57082","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-09-18T05:08:37.278727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.15426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-09-18T05:08:37.27997Z","caller":"traceutil/trace.go:171","msg":"trace[878058831] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"133.445231ms","start":"2026-09-18T05:08:37.146511Z","end":"2026-09-18T05:08:37.279956Z","steps":["trace[878058831] 'agreement among raft nodes before linearized reading' (duration: 132.16665ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.278763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.604828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-09-18T05:08:37.280174Z","caller":"traceutil/trace.go:171","msg":"trace[534194263] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"297.075075ms","start":"2026-09-18T05:08:36.983086Z","end":"2026-09-18T05:08:37.280161Z","steps":["trace[534194263] 'agreement among raft nodes before linearized reading' (duration: 295.616659ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.278782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.527399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-09-18T05:08:37.280391Z","caller":"traceutil/trace.go:171","msg":"trace[317087676] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"799.155379ms","start":"2026-09-18T05:08:36.481222Z","end":"2026-09-18T05:08:37.280377Z","steps":["trace[317087676] 'agreement among raft nodes before linearized reading' (duration: 797.531509ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.280447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.481214Z","time spent":"799.21089ms","remote":"127.0.0.1:57192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-18T05:08:37.278829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.075211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-ltdls\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-09-18T05:08:37.280638Z","caller":"traceutil/trace.go:171","msg":"trace[2033104434] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-ltdls; range_end:; response_count:1; response_revision:19; }","duration":"299.872215ms","start":"2026-09-18T05:08:36.980692Z","end":"2026-09-18T05:08:37.280564Z","steps":["trace[2033104434] 'agreement among raft nodes before linearized reading' (duration: 298.105362ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.280698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.98067Z","time spent":"300.011708ms","remote":"127.0.0.1:57304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":880,"request content":"key:\"/registry/certificatesigningrequests/csr-ltdls\" "} {"level":"info","ts":"2026-09-18T05:08:37.278881Z","caller":"traceutil/trace.go:171","msg":"trace[671256925] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"295.548347ms","start":"2026-09-18T05:08:36.983316Z","end":"2026-09-18T05:08:37.278864Z","steps":["trace[671256925] 'process raft request' (duration: 294.390638ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.279868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.97701Z","time spent":"301.301942ms","remote":"127.0.0.1:57144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:08:37.278926Z","caller":"traceutil/trace.go:171","msg":"trace[2102737475] transaction","detail":"{read_only:false; number_of_response:0; response_revision:18; }","duration":"295.478805ms","start":"2026-09-18T05:08:36.983439Z","end":"2026-09-18T05:08:37.278918Z","steps":["trace[2102737475] 'process raft request' (duration: 294.339607ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:37.279315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:36.479177Z","time spent":"798.503743ms","remote":"127.0.0.1:57134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:09:14.376523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.958158ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-18T05:09:14.376876Z","caller":"traceutil/trace.go:171","msg":"trace[607928931] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"243.889756ms","start":"2026-09-18T05:09:14.132969Z","end":"2026-09-18T05:09:14.376859Z","steps":["trace[607928931] 'process raft request' (duration: 243.806934ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:14.376937Z","caller":"traceutil/trace.go:171","msg":"trace[1413308758] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"245.57171ms","start":"2026-09-18T05:09:14.131324Z","end":"2026-09-18T05:09:14.376895Z","steps":["trace[1413308758] 'process raft request' (duration: 245.310574ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:16.392886Z","caller":"traceutil/trace.go:171","msg":"trace[1704721893] transaction","detail":"{read_only:false; number_of_response:0; response_revision:555; }","duration":"321.877666ms","start":"2026-09-18T05:09:16.070966Z","end":"2026-09-18T05:09:16.392843Z","steps":["trace[1704721893] 'process raft request' (duration: 304.062817ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:16.392934Z","caller":"traceutil/trace.go:171","msg":"trace[1932284374] transaction","detail":"{read_only:false; number_of_response:0; response_revision:555; }","duration":"321.866696ms","start":"2026-09-18T05:09:16.07104Z","end":"2026-09-18T05:09:16.392906Z","steps":["trace[1932284374] 'process raft request' (duration: 321.644362ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:16.392951Z","caller":"traceutil/trace.go:171","msg":"trace[140360993] transaction","detail":"{read_only:false; number_of_response:0; response_revision:555; }","duration":"321.881786ms","start":"2026-09-18T05:09:16.071017Z","end":"2026-09-18T05:09:16.392899Z","steps":["trace[140360993] 'process raft request' (duration: 321.633271ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:16.39306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:16.070946Z","time spent":"322.03812ms","remote":"127.0.0.1:57600","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T05:09:16.393088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:16.071029Z","time spent":"321.983248ms","remote":"127.0.0.1:57600","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T05:09:16.393331Z","caller":"traceutil/trace.go:171","msg":"trace[99242341] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"321.077719ms","start":"2026-09-18T05:09:16.072229Z","end":"2026-09-18T05:09:16.393307Z","steps":["trace[99242341] 'process raft request' (duration: 320.579259ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:16.39348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:16.072211Z","time spent":"321.177732ms","remote":"127.0.0.1:57130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:09:16.393496Z","caller":"traceutil/trace.go:171","msg":"trace[576386648] transaction","detail":"{read_only:false; number_of_response:1; response_revision:556; }","duration":"321.086509ms","start":"2026-09-18T05:09:16.072388Z","end":"2026-09-18T05:09:16.393475Z","steps":["trace[576386648] 'process raft request' (duration: 320.828774ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:16.393999Z","caller":"traceutil/trace.go:171","msg":"trace[111288809] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"196.68396ms","start":"2026-09-18T05:09:16.197296Z","end":"2026-09-18T05:09:16.39398Z","steps":["trace[111288809] 'process raft request' (duration: 196.602289ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:16.39401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:16.072378Z","time spent":"321.57562ms","remote":"127.0.0.1:57130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10112,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:09:16.394116Z","caller":"traceutil/trace.go:171","msg":"trace[1789824721] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"308.413466ms","start":"2026-09-18T05:09:16.085681Z","end":"2026-09-18T05:09:16.394094Z","steps":["trace[1789824721] 'process raft request' (duration: 308.103329ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:16.394183Z","caller":"traceutil/trace.go:171","msg":"trace[121487838] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"315.62178ms","start":"2026-09-18T05:09:16.078543Z","end":"2026-09-18T05:09:16.394165Z","steps":["trace[121487838] 'process raft request' (duration: 315.077118ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:16.394174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:16.071014Z","time spent":"322.009279ms","remote":"127.0.0.1:57600","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T05:09:16.394235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:16.085657Z","time spent":"308.529008ms","remote":"127.0.0.1:57130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:09:16.393601Z","caller":"traceutil/trace.go:171","msg":"trace[767632752] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"317.492787ms","start":"2026-09-18T05:09:16.076046Z","end":"2026-09-18T05:09:16.393538Z","steps":["trace[767632752] 'process raft request' (duration: 317.371624ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:16.394253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:16.078535Z","time spent":"315.684001ms","remote":"127.0.0.1:57130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T05:09:16.394386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:16.076035Z","time spent":"318.319915ms","remote":"127.0.0.1:57130","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-09-18T05:09:22.508829Z","caller":"traceutil/trace.go:171","msg":"trace[832730664] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"131.906186ms","start":"2026-09-18T05:09:22.376902Z","end":"2026-09-18T05:09:22.508808Z","steps":["trace[832730664] 'process raft request' (duration: 131.689422ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:22.927966Z","caller":"traceutil/trace.go:171","msg":"trace[1895391001] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"125.209475ms","start":"2026-09-18T05:09:22.802711Z","end":"2026-09-18T05:09:22.92792Z","steps":["trace[1895391001] 'process raft request' (duration: 124.522422ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:23.539583Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":188483449719915604,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-18T05:09:23.623931Z","caller":"traceutil/trace.go:171","msg":"trace[1658606100] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"585.021017ms","start":"2026-09-18T05:09:23.03889Z","end":"2026-09-18T05:09:23.623911Z","steps":["trace[1658606100] 'read index received' (duration: 584.444376ms)","trace[1658606100] 'applied index is now lower than readState.Index' (duration: 576.061µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:09:23.624136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.211531ms","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-09-18T05:09:23.624166Z","caller":"traceutil/trace.go:171","msg":"trace[74873069] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"585.306963ms","start":"2026-09-18T05:09:23.03885Z","end":"2026-09-18T05:09:23.624157Z","steps":["trace[74873069] 'agreement among raft nodes before linearized reading' (duration: 585.14889ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:23.62419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:23.038831Z","time spent":"585.352665ms","remote":"127.0.0.1:57320","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-09-18T05:09:23.624322Z","caller":"traceutil/trace.go:171","msg":"trace[896213421] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"621.38735ms","start":"2026-09-18T05:09:23.0027Z","end":"2026-09-18T05:09:23.624087Z","steps":["trace[896213421] 'process raft request' (duration: 620.84061ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:23.624409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.383258ms","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-09-18T05:09:23.624514Z","caller":"traceutil/trace.go:171","msg":"trace[1909112710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"150.540461ms","start":"2026-09-18T05:09:23.47395Z","end":"2026-09-18T05:09:23.62449Z","steps":["trace[1909112710] 'agreement among raft nodes before linearized reading' (duration: 150.180803ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:23.62528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:23.002677Z","time spent":"621.80044ms","remote":"127.0.0.1:57170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:09:25.050033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.022257ms","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-09-18T05:09:25.050144Z","caller":"traceutil/trace.go:171","msg":"trace[1571054584] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:679; }","duration":"105.144571ms","start":"2026-09-18T05:09:24.944952Z","end":"2026-09-18T05:09:25.050096Z","steps":["trace[1571054584] 'range keys from in-memory index tree' (duration: 104.930926ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:50.695665Z","caller":"traceutil/trace.go:171","msg":"trace[1226701659] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:996; }","duration":"106.21858ms","start":"2026-09-18T05:09:50.589421Z","end":"2026-09-18T05:09:50.695639Z","steps":["trace[1226701659] 'read index received' (duration: 106.037616ms)","trace[1226701659] 'applied index is now lower than readState.Index' (duration: 180.284µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:09:50.695805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.368942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:09:50.695836Z","caller":"traceutil/trace.go:171","msg":"trace[1795221023] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:963; }","duration":"106.450384ms","start":"2026-09-18T05:09:50.589375Z","end":"2026-09-18T05:09:50.695826Z","steps":["trace[1795221023] 'agreement among raft nodes before linearized reading' (duration: 106.362282ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:50.696204Z","caller":"traceutil/trace.go:171","msg":"trace[1796507373] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"172.446873ms","start":"2026-09-18T05:09:50.523737Z","end":"2026-09-18T05:09:50.696184Z","steps":["trace[1796507373] 'process raft request' (duration: 171.769551ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:59.339863Z","caller":"traceutil/trace.go:171","msg":"trace[829302528] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"104.27053ms","start":"2026-09-18T05:09:59.235567Z","end":"2026-09-18T05:09:59.339838Z","steps":["trace[829302528] 'process raft request' (duration: 104.141988ms)"],"step_count":1}