{"level":"warn","ts":"2026-10-16T16:29:09.624406Z","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-16T16:29:09.624688Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.92: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.92:2380","--initial-cluster=instance=https://162.253.55.92:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.92:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.92: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-16T16:29:09.624772Z","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-16T16:29:09.62478Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.92:2380"]} {"level":"info","ts":"2026-10-16T16:29:09.624802Z","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-16T16:29:09.625426Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.92:2379"]} {"level":"info","ts":"2026-10-16T16:29:09.625495Z","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.92:2380"],"listen-peer-urls":["https://162.253.55.92:2380"],"advertise-client-urls":["https://162.253.55.92:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.92:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.92: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-16T16:29:09.632954Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.26062ms"} {"level":"info","ts":"2026-10-16T16:29:09.650648Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39a4f14f6507253d","cluster-id":"22d06cab78b8ace5"} {"level":"info","ts":"2026-10-16T16:29:09.65078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d switched to configuration voters=()"} {"level":"info","ts":"2026-10-16T16:29:09.650824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became follower at term 0"} {"level":"info","ts":"2026-10-16T16:29:09.650876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39a4f14f6507253d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-16T16:29:09.650895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became follower at term 1"} {"level":"info","ts":"2026-10-16T16:29:09.650948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d switched to configuration voters=(4153710079642117437)"} {"level":"warn","ts":"2026-10-16T16:29:09.661195Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-16T16:29:09.664348Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-16T16:29:09.667174Z","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-16T16:29:09.672184Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39a4f14f6507253d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-16T16:29:09.67393Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39a4f14f6507253d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-16T16:29:09.67403Z","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-16T16:29:09.674073Z","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-16T16:29:09.674086Z","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-16T16:29:09.674507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d switched to configuration voters=(4153710079642117437)"} {"level":"info","ts":"2026-10-16T16:29:09.676051Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"22d06cab78b8ace5","local-member-id":"39a4f14f6507253d","added-peer-id":"39a4f14f6507253d","added-peer-peer-urls":["https://162.253.55.92:2380"]} {"level":"info","ts":"2026-10-16T16:29:09.677926Z","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-16T16:29:09.678102Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.92:2380"} {"level":"info","ts":"2026-10-16T16:29:09.678247Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.92:2380"} {"level":"info","ts":"2026-10-16T16:29:09.678474Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39a4f14f6507253d","initial-advertise-peer-urls":["https://162.253.55.92:2380"],"listen-peer-urls":["https://162.253.55.92:2380"],"advertise-client-urls":["https://162.253.55.92:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.92:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-16T16:29:09.678513Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-16T16:29:09.752027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d is starting a new election at term 1"} {"level":"info","ts":"2026-10-16T16:29:09.752082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became pre-candidate at term 1"} {"level":"info","ts":"2026-10-16T16:29:09.752102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d received MsgPreVoteResp from 39a4f14f6507253d at term 1"} {"level":"info","ts":"2026-10-16T16:29:09.752114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became candidate at term 2"} {"level":"info","ts":"2026-10-16T16:29:09.75212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d received MsgVoteResp from 39a4f14f6507253d at term 2"} {"level":"info","ts":"2026-10-16T16:29:09.752128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39a4f14f6507253d became leader at term 2"} {"level":"info","ts":"2026-10-16T16:29:09.752135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39a4f14f6507253d elected leader 39a4f14f6507253d at term 2"} {"level":"info","ts":"2026-10-16T16:29:09.768855Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39a4f14f6507253d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.92:2379]}","request-path":"/0/members/39a4f14f6507253d/attributes","cluster-id":"22d06cab78b8ace5","publish-timeout":"7s"} {"level":"info","ts":"2026-10-16T16:29:09.768988Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-16T16:29:09.769322Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-16T16:29:09.769458Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-16T16:29:09.769428Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T16:29:09.769158Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-16T16:29:09.771449Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.92:2379"} {"level":"info","ts":"2026-10-16T16:29:09.773463Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-16T16:29:09.811915Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"22d06cab78b8ace5","local-member-id":"39a4f14f6507253d","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T16:29:09.812185Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T16:29:09.812273Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T16:29:12.574951Z","caller":"traceutil/trace.go:171","msg":"trace[416326773] linearizableReadLoop","detail":"{readStateIndex:117; appliedIndex:116; }","duration":"229.17225ms","start":"2026-10-16T16:29:12.345753Z","end":"2026-10-16T16:29:12.574926Z","steps":["trace[416326773] 'read index received' (duration: 228.915365ms)","trace[416326773] 'applied index is now lower than readState.Index' (duration: 255.955µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T16:29:12.575014Z","caller":"traceutil/trace.go:171","msg":"trace[1142595846] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"249.656799ms","start":"2026-10-16T16:29:12.325322Z","end":"2026-10-16T16:29:12.574978Z","steps":["trace[1142595846] 'process raft request' (duration: 249.472135ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:12.575155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.402065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-16T16:29:12.575196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.635225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-16T16:29:12.575155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.384513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-16T16:29:12.575236Z","caller":"traceutil/trace.go:171","msg":"trace[423490859] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:112; }","duration":"220.511417ms","start":"2026-10-16T16:29:12.354711Z","end":"2026-10-16T16:29:12.575222Z","steps":["trace[423490859] 'agreement among raft nodes before linearized reading' (duration: 220.401115ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:12.575242Z","caller":"traceutil/trace.go:171","msg":"trace[1293082882] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:112; }","duration":"149.721396ms","start":"2026-10-16T16:29:12.425506Z","end":"2026-10-16T16:29:12.575227Z","steps":["trace[1293082882] 'agreement among raft nodes before linearized reading' (duration: 149.658105ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:12.575259Z","caller":"traceutil/trace.go:171","msg":"trace[953560249] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:112; }","duration":"229.541685ms","start":"2026-10-16T16:29:12.345699Z","end":"2026-10-16T16:29:12.57524Z","steps":["trace[953560249] 'agreement among raft nodes before linearized reading' (duration: 229.360602ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:12.575567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.962849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-16T16:29:12.57563Z","caller":"traceutil/trace.go:171","msg":"trace[1843222233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:112; }","duration":"122.447959ms","start":"2026-10-16T16:29:12.453139Z","end":"2026-10-16T16:29:12.575587Z","steps":["trace[1843222233] 'agreement among raft nodes before linearized reading' (duration: 121.97007ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:13.02861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.072269ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-16T16:29:13.028747Z","caller":"traceutil/trace.go:171","msg":"trace[1746909973] linearizableReadLoop","detail":"{readStateIndex:118; appliedIndex:117; }","duration":"448.850031ms","start":"2026-10-16T16:29:12.579882Z","end":"2026-10-16T16:29:13.028732Z","steps":["trace[1746909973] 'read index received' (duration: 168.260281ms)","trace[1746909973] 'applied index is now lower than readState.Index' (duration: 280.588609ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T16:29:13.028817Z","caller":"traceutil/trace.go:171","msg":"trace[1218583206] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"450.03281ms","start":"2026-10-16T16:29:12.578726Z","end":"2026-10-16T16:29:13.028759Z","steps":["trace[1218583206] 'process raft request' (duration: 169.37843ms)","trace[1218583206] 'compare' (duration: 279.940207ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T16:29:13.028851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.968862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-16T16:29:13.02889Z","caller":"traceutil/trace.go:171","msg":"trace[1281254146] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:113; }","duration":"449.077714ms","start":"2026-10-16T16:29:12.579802Z","end":"2026-10-16T16:29:13.02888Z","steps":["trace[1281254146] 'agreement among raft nodes before linearized reading' (duration: 448.969172ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:13.02892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:12.579787Z","time spent":"449.125675ms","remote":"127.0.0.1:60594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-10-16T16:29:13.02897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:12.578673Z","time spent":"450.218963ms","remote":"127.0.0.1:60614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T16:29:39.673451Z","caller":"traceutil/trace.go:171","msg":"trace[2083731857] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"115.765153ms","start":"2026-10-16T16:29:39.557648Z","end":"2026-10-16T16:29:39.673413Z","steps":["trace[2083731857] 'process raft request' (duration: 49.498904ms)","trace[2083731857] 'compare' (duration: 66.018516ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T16:29:39.673535Z","caller":"traceutil/trace.go:171","msg":"trace[747793296] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"114.883871ms","start":"2026-10-16T16:29:39.558617Z","end":"2026-10-16T16:29:39.673501Z","steps":["trace[747793296] 'process raft request' (duration: 114.728088ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:39.673604Z","caller":"traceutil/trace.go:171","msg":"trace[1289340486] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"113.032042ms","start":"2026-10-16T16:29:39.560542Z","end":"2026-10-16T16:29:39.673574Z","steps":["trace[1289340486] 'process raft request' (duration: 112.860889ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:39.673607Z","caller":"traceutil/trace.go:171","msg":"trace[525492984] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"111.761553ms","start":"2026-10-16T16:29:39.561822Z","end":"2026-10-16T16:29:39.673584Z","steps":["trace[525492984] 'process raft request' (duration: 111.661032ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:53.385854Z","caller":"traceutil/trace.go:171","msg":"trace[91916593] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"128.176853ms","start":"2026-10-16T16:29:53.257655Z","end":"2026-10-16T16:29:53.385832Z","steps":["trace[91916593] 'process raft request' (duration: 128.042561ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:53.667701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.096253ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-16T16:29:53.667991Z","caller":"traceutil/trace.go:171","msg":"trace[679146375] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"406.087958ms","start":"2026-10-16T16:29:53.26187Z","end":"2026-10-16T16:29:53.667958Z","steps":["trace[679146375] 'process raft request' (duration: 167.641471ms)","trace[679146375] 'compare' (duration: 237.964411ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T16:29:53.668107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.261843Z","time spent":"406.21756ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T16:29:53.668325Z","caller":"traceutil/trace.go:171","msg":"trace[844892311] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"383.019276ms","start":"2026-10-16T16:29:53.28526Z","end":"2026-10-16T16:29:53.668279Z","steps":["trace[844892311] 'process raft request' (duration: 382.705111ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:53.668369Z","caller":"traceutil/trace.go:171","msg":"trace[914580652] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"385.870657ms","start":"2026-10-16T16:29:53.282483Z","end":"2026-10-16T16:29:53.668353Z","steps":["trace[914580652] 'process raft request' (duration: 385.40406ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:53.668391Z","caller":"traceutil/trace.go:171","msg":"trace[608139331] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:560; }","duration":"395.663108ms","start":"2026-10-16T16:29:53.272688Z","end":"2026-10-16T16:29:53.668351Z","steps":["trace[608139331] 'read index received' (duration: 113.165957ms)","trace[608139331] 'applied index is now lower than readState.Index' (duration: 282.496061ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T16:29:53.668408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.285255Z","time spent":"383.117117ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T16:29:53.668438Z","caller":"traceutil/trace.go:171","msg":"trace[1411824511] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"383.227739ms","start":"2026-10-16T16:29:53.285203Z","end":"2026-10-16T16:29:53.66843Z","steps":["trace[1411824511] 'process raft request' (duration: 382.724592ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:53.668446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.282465Z","time spent":"385.940298ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-16T16:29:53.66848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.28519Z","time spent":"383.27276ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T16:29:53.668506Z","caller":"traceutil/trace.go:171","msg":"trace[1464582302] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"383.014756ms","start":"2026-10-16T16:29:53.285479Z","end":"2026-10-16T16:29:53.668493Z","steps":["trace[1464582302] 'process raft request' (duration: 382.524169ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:53.668548Z","caller":"traceutil/trace.go:171","msg":"trace[572037107] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"406.554385ms","start":"2026-10-16T16:29:53.261982Z","end":"2026-10-16T16:29:53.668536Z","steps":["trace[572037107] 'process raft request' (duration: 405.839104ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:53.66858Z","caller":"traceutil/trace.go:171","msg":"trace[1080554547] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"383.036106ms","start":"2026-10-16T16:29:53.285536Z","end":"2026-10-16T16:29:53.668572Z","steps":["trace[1080554547] 'process raft request' (duration: 382.507028ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:53.668605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.261973Z","time spent":"406.604915ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T16:29:53.668645Z","caller":"traceutil/trace.go:171","msg":"trace[174504180] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"376.477802ms","start":"2026-10-16T16:29:53.292159Z","end":"2026-10-16T16:29:53.668637Z","steps":["trace[174504180] 'process raft request' (duration: 375.922114ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:53.668678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.292135Z","time spent":"376.528302ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-16T16:29:53.668553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.28547Z","time spent":"383.057866ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-16T16:29:53.668615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.285531Z","time spent":"383.067677ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T16:29:53.668774Z","caller":"traceutil/trace.go:171","msg":"trace[736419205] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"376.229918ms","start":"2026-10-16T16:29:53.292535Z","end":"2026-10-16T16:29:53.668765Z","steps":["trace[736419205] 'process raft request' (duration: 375.67101ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:53.668808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.110044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T16:29:53.668829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.292524Z","time spent":"376.275728ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T16:29:53.668841Z","caller":"traceutil/trace.go:171","msg":"trace[1018718416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:549; }","duration":"396.179425ms","start":"2026-10-16T16:29:53.272653Z","end":"2026-10-16T16:29:53.668833Z","steps":["trace[1018718416] 'agreement among raft nodes before linearized reading' (duration: 396.101384ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:53.668869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.272638Z","time spent":"396.225755ms","remote":"127.0.0.1:60284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-16T16:29:53.668743Z","caller":"traceutil/trace.go:171","msg":"trace[612923318] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"331.988422ms","start":"2026-10-16T16:29:53.33674Z","end":"2026-10-16T16:29:53.668728Z","steps":["trace[612923318] 'process raft request' (duration: 331.517435ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:53.66902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.33671Z","time spent":"332.225535ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T16:29:53.711756Z","caller":"traceutil/trace.go:171","msg":"trace[496207383] transaction","detail":"{read_only:false; number_of_response:1; response_revision:551; }","duration":"318.256436ms","start":"2026-10-16T16:29:53.393463Z","end":"2026-10-16T16:29:53.711719Z","steps":["trace[496207383] 'process raft request' (duration: 318.174125ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:53.711911Z","caller":"traceutil/trace.go:171","msg":"trace[1320473454] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"320.62265ms","start":"2026-10-16T16:29:53.391259Z","end":"2026-10-16T16:29:53.711881Z","steps":["trace[1320473454] 'process raft request' (duration: 320.095763ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:53.712051Z","caller":"traceutil/trace.go:171","msg":"trace[843731113] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"318.892324ms","start":"2026-10-16T16:29:53.393135Z","end":"2026-10-16T16:29:53.712027Z","steps":["trace[843731113] 'process raft request' (duration: 318.420747ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:53.712062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.391235Z","time spent":"320.759132ms","remote":"127.0.0.1:60776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-16T16:29:53.712287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.393454Z","time spent":"318.406498ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7365,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T16:29:53.712458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:53.393125Z","time spent":"318.968685ms","remote":"127.0.0.1:60338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T16:29:53.720699Z","caller":"traceutil/trace.go:171","msg":"trace[1588746615] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"222.629081ms","start":"2026-10-16T16:29:53.498038Z","end":"2026-10-16T16:29:53.720667Z","steps":["trace[1588746615] 'process raft request' (duration: 221.90847ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:29:59.353703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.117498ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-10-16T16:29:59.753839Z","caller":"traceutil/trace.go:171","msg":"trace[395381976] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"171.751076ms","start":"2026-10-16T16:29:59.582056Z","end":"2026-10-16T16:29:59.753807Z","steps":["trace[395381976] 'process raft request' (duration: 171.000475ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T16:29:59.909075Z","caller":"traceutil/trace.go:171","msg":"trace[1903739696] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"137.25499ms","start":"2026-10-16T16:29:59.771792Z","end":"2026-10-16T16:29:59.909047Z","steps":["trace[1903739696] 'process raft request' (duration: 110.774538ms)","trace[1903739696] 'compare' (duration: 26.32368ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T16:30:00.535797Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2683478273052285048,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-16T16:30:00.556425Z","caller":"traceutil/trace.go:171","msg":"trace[1427320513] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"607.296252ms","start":"2026-10-16T16:29:59.949105Z","end":"2026-10-16T16:30:00.556401Z","steps":["trace[1427320513] 'process raft request' (duration: 600.308004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:30:00.556564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:29:59.949077Z","time spent":"607.409144ms","remote":"127.0.0.1:60492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T16:30:00.611732Z","caller":"traceutil/trace.go:171","msg":"trace[1589460774] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:666; }","duration":"576.63596ms","start":"2026-10-16T16:30:00.035013Z","end":"2026-10-16T16:30:00.611649Z","steps":["trace[1589460774] 'read index received' (duration: 514.429628ms)","trace[1589460774] 'applied index is now lower than readState.Index' (duration: 62.204622ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T16:30:00.611788Z","caller":"traceutil/trace.go:171","msg":"trace[160359611] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"296.092308ms","start":"2026-10-16T16:30:00.315647Z","end":"2026-10-16T16:30:00.61174Z","steps":["trace[160359611] 'process raft request' (duration: 291.402103ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:30:00.612069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.024105ms","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-16T16:30:00.612187Z","caller":"traceutil/trace.go:171","msg":"trace[1034315941] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"577.204039ms","start":"2026-10-16T16:30:00.034969Z","end":"2026-10-16T16:30:00.612173Z","steps":["trace[1034315941] 'agreement among raft nodes before linearized reading' (duration: 576.924825ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:30:00.61247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:30:00.03495Z","time spent":"577.507583ms","remote":"127.0.0.1:60492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-16T16:30:00.612709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.127263ms","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-16T16:30:00.612752Z","caller":"traceutil/trace.go:171","msg":"trace[627299120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:639; }","duration":"571.216675ms","start":"2026-10-16T16:30:00.041522Z","end":"2026-10-16T16:30:00.612739Z","steps":["trace[627299120] 'agreement among raft nodes before linearized reading' (duration: 571.077443ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T16:30:00.61277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T16:30:00.041502Z","time spent":"571.263605ms","remote":"127.0.0.1:60492","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-16T16:30:00.612779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.325181ms","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-16T16:30:00.612847Z","caller":"traceutil/trace.go:171","msg":"trace[113151418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"298.424752ms","start":"2026-10-16T16:30:00.314403Z","end":"2026-10-16T16:30:00.612828Z","steps":["trace[113151418] 'agreement among raft nodes before linearized reading' (duration: 298.220369ms)"],"step_count":1}