{"level":"warn","ts":"2026-10-06T10:04:21.706019Z","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-06T10:04:21.706115Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.10: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.10:2380","--initial-cluster=instance=https://162.253.55.10:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.10:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.10: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-06T10:04:21.706213Z","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-06T10:04:21.706226Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.10:2380"]} {"level":"info","ts":"2026-10-06T10:04:21.706244Z","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-06T10:04:21.707346Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.10:2379"]} {"level":"info","ts":"2026-10-06T10:04:21.707464Z","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.10:2380"],"listen-peer-urls":["https://162.253.55.10:2380"],"advertise-client-urls":["https://162.253.55.10:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.10:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.10: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-06T10:04:21.710795Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.977735ms"} {"level":"info","ts":"2026-10-06T10:04:21.716671Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"373d5d49ce4adaff","cluster-id":"467836e907a15d60"} {"level":"info","ts":"2026-10-06T10:04:21.716737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff switched to configuration voters=()"} {"level":"info","ts":"2026-10-06T10:04:21.716757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff became follower at term 0"} {"level":"info","ts":"2026-10-06T10:04:21.716766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 373d5d49ce4adaff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-06T10:04:21.716774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff became follower at term 1"} {"level":"info","ts":"2026-10-06T10:04:21.716808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff switched to configuration voters=(3980440217240394495)"} {"level":"warn","ts":"2026-10-06T10:04:21.722803Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-06T10:04:21.724562Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-06T10:04:21.727311Z","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-06T10:04:21.72997Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"373d5d49ce4adaff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-06T10:04:21.730755Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"373d5d49ce4adaff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-06T10:04:21.730924Z","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-06T10:04:21.730997Z","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-06T10:04:21.731046Z","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-06T10:04:21.732294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff switched to configuration voters=(3980440217240394495)"} {"level":"info","ts":"2026-10-06T10:04:21.732684Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"467836e907a15d60","local-member-id":"373d5d49ce4adaff","added-peer-id":"373d5d49ce4adaff","added-peer-peer-urls":["https://162.253.55.10:2380"]} {"level":"info","ts":"2026-10-06T10:04:21.734387Z","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-06T10:04:21.734518Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.10:2380"} {"level":"info","ts":"2026-10-06T10:04:21.734568Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.10:2380"} {"level":"info","ts":"2026-10-06T10:04:21.734843Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"373d5d49ce4adaff","initial-advertise-peer-urls":["https://162.253.55.10:2380"],"listen-peer-urls":["https://162.253.55.10:2380"],"advertise-client-urls":["https://162.253.55.10:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.10:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-06T10:04:21.734907Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-06T10:04:22.217414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff is starting a new election at term 1"} {"level":"info","ts":"2026-10-06T10:04:22.217466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff became pre-candidate at term 1"} {"level":"info","ts":"2026-10-06T10:04:22.217498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff received MsgPreVoteResp from 373d5d49ce4adaff at term 1"} {"level":"info","ts":"2026-10-06T10:04:22.217516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff became candidate at term 2"} {"level":"info","ts":"2026-10-06T10:04:22.217528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff received MsgVoteResp from 373d5d49ce4adaff at term 2"} {"level":"info","ts":"2026-10-06T10:04:22.217547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"373d5d49ce4adaff became leader at term 2"} {"level":"info","ts":"2026-10-06T10:04:22.217564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 373d5d49ce4adaff elected leader 373d5d49ce4adaff at term 2"} {"level":"info","ts":"2026-10-06T10:04:22.382788Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"373d5d49ce4adaff","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.10:2379]}","request-path":"/0/members/373d5d49ce4adaff/attributes","cluster-id":"467836e907a15d60","publish-timeout":"7s"} {"level":"info","ts":"2026-10-06T10:04:22.382911Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-06T10:04:22.383293Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-06T10:04:22.383424Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-06T10:04:22.385585Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-06T10:04:22.385612Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-06T10:04:22.388256Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-06T10:04:22.388549Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.10:2379"} {"level":"info","ts":"2026-10-06T10:04:22.574277Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"467836e907a15d60","local-member-id":"373d5d49ce4adaff","cluster-version":"3.5"} {"level":"info","ts":"2026-10-06T10:04:22.574434Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-06T10:04:22.574491Z","caller":"traceutil/trace.go:171","msg":"trace[1552642739] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"134.354615ms","start":"2026-10-06T10:04:22.440121Z","end":"2026-10-06T10:04:22.574476Z","steps":["trace[1552642739] 'read index received' (duration: 134.107997ms)","trace[1552642739] 'applied index is now lower than readState.Index' (duration: 245.438µs)"],"step_count":2} {"level":"info","ts":"2026-10-06T10:04:22.574614Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-10-06T10:04:22.57474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.586782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.574803Z","caller":"traceutil/trace.go:171","msg":"trace[1876693652] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"134.673455ms","start":"2026-10-06T10:04:22.440117Z","end":"2026-10-06T10:04:22.57479Z","steps":["trace[1876693652] 'agreement among raft nodes before linearized reading' (duration: 134.435477ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:04:22.574932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.692625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.575067Z","caller":"traceutil/trace.go:171","msg":"trace[116438668] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"134.874231ms","start":"2026-10-06T10:04:22.440167Z","end":"2026-10-06T10:04:22.575041Z","steps":["trace[116438668] 'agreement among raft nodes before linearized reading' (duration: 134.579841ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:04:22.770223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.952428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-06T10:04:22.770424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.093672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.770472Z","caller":"traceutil/trace.go:171","msg":"trace[108145683] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"148.195546ms","start":"2026-10-06T10:04:22.622266Z","end":"2026-10-06T10:04:22.770462Z","steps":["trace[108145683] 'range keys from in-memory index tree' (duration: 147.999889ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:04:22.770604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.417612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.770626Z","caller":"traceutil/trace.go:171","msg":"trace[1659221282] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"137.455784ms","start":"2026-10-06T10:04:22.633165Z","end":"2026-10-06T10:04:22.77062Z","steps":["trace[1659221282] 'range keys from in-memory index tree' (duration: 137.35216ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:04:22.770733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.489834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.770763Z","caller":"traceutil/trace.go:171","msg":"trace[1694361815] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"137.544096ms","start":"2026-10-06T10:04:22.633211Z","end":"2026-10-06T10:04:22.770755Z","steps":["trace[1694361815] 'count revisions from in-memory index tree' (duration: 137.446513ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:04:22.770845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.217524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.770891Z","caller":"traceutil/trace.go:171","msg":"trace[2055589559] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"130.264315ms","start":"2026-10-06T10:04:22.640612Z","end":"2026-10-06T10:04:22.770876Z","steps":["trace[2055589559] 'range keys from in-memory index tree' (duration: 130.190512ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:04:22.771042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.356128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.77106Z","caller":"traceutil/trace.go:171","msg":"trace[991479732] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"130.400069ms","start":"2026-10-06T10:04:22.640656Z","end":"2026-10-06T10:04:22.771056Z","steps":["trace[991479732] 'count revisions from in-memory index tree' (duration: 130.270576ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:04:22.771137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.645801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.771155Z","caller":"traceutil/trace.go:171","msg":"trace[1520915286] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"121.674521ms","start":"2026-10-06T10:04:22.649476Z","end":"2026-10-06T10:04:22.771151Z","steps":["trace[1520915286] 'count revisions from in-memory index tree' (duration: 121.60984ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:04:22.771239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.715443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.771256Z","caller":"traceutil/trace.go:171","msg":"trace[965830898] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"121.759424ms","start":"2026-10-06T10:04:22.649492Z","end":"2026-10-06T10:04:22.771252Z","steps":["trace[965830898] 'range keys from in-memory index tree' (duration: 121.670291ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:04:22.771361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.121146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.7714Z","caller":"traceutil/trace.go:171","msg":"trace[1629696619] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"111.178658ms","start":"2026-10-06T10:04:22.660213Z","end":"2026-10-06T10:04:22.771392Z","steps":["trace[1629696619] 'count revisions from in-memory index tree' (duration: 111.025553ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:04:22.771513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.23983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-06T10:04:22.771533Z","caller":"traceutil/trace.go:171","msg":"trace[28361994] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"111.284591ms","start":"2026-10-06T10:04:22.660242Z","end":"2026-10-06T10:04:22.771527Z","steps":["trace[28361994] 'range keys from in-memory index tree' (duration: 111.160747ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:04:22.770455Z","caller":"traceutil/trace.go:171","msg":"trace[852200028] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"148.217216ms","start":"2026-10-06T10:04:22.622222Z","end":"2026-10-06T10:04:22.770439Z","steps":["trace[852200028] 'count revisions from in-memory index tree' (duration: 147.894076ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:05:04.402786Z","caller":"traceutil/trace.go:171","msg":"trace[958898149] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"181.67189ms","start":"2026-10-06T10:05:04.221031Z","end":"2026-10-06T10:05:04.402702Z","steps":["trace[958898149] 'process raft request' (duration: 152.859264ms)","trace[958898149] 'compare' (duration: 28.686952ms)"],"step_count":2} {"level":"info","ts":"2026-10-06T10:05:05.260234Z","caller":"traceutil/trace.go:171","msg":"trace[693939986] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"323.068459ms","start":"2026-10-06T10:05:04.937141Z","end":"2026-10-06T10:05:05.26021Z","steps":["trace[693939986] 'read index received' (duration: 322.287004ms)","trace[693939986] 'applied index is now lower than readState.Index' (duration: 780.145µs)"],"step_count":2} {"level":"info","ts":"2026-10-06T10:05:05.260354Z","caller":"traceutil/trace.go:171","msg":"trace[484579395] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"435.054701ms","start":"2026-10-06T10:05:04.825266Z","end":"2026-10-06T10:05:05.260321Z","steps":["trace[484579395] 'process raft request' (duration: 434.416171ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:05:05.260427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.231554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-06T10:05:05.260474Z","caller":"traceutil/trace.go:171","msg":"trace[1287136644] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"323.360818ms","start":"2026-10-06T10:05:04.937097Z","end":"2026-10-06T10:05:05.260458Z","steps":["trace[1287136644] 'agreement among raft nodes before linearized reading' (duration: 323.239494ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:05:05.260518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:05:04.937078Z","time spent":"323.42742ms","remote":"127.0.0.1:40174","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-10-06T10:05:05.261132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:05:04.825237Z","time spent":"435.197416ms","remote":"127.0.0.1:40282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-06T10:05:05.439126Z","caller":"traceutil/trace.go:171","msg":"trace[431896027] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"110.386252ms","start":"2026-10-06T10:05:05.328716Z","end":"2026-10-06T10:05:05.439103Z","steps":["trace[431896027] 'process raft request' (duration: 89.557199ms)","trace[431896027] 'compare' (duration: 20.709119ms)"],"step_count":2} {"level":"info","ts":"2026-10-06T10:05:06.992212Z","caller":"traceutil/trace.go:171","msg":"trace[708739611] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"212.313806ms","start":"2026-10-06T10:05:06.779876Z","end":"2026-10-06T10:05:06.99219Z","steps":["trace[708739611] 'process raft request' (duration: 212.183201ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:05:07.017317Z","caller":"traceutil/trace.go:171","msg":"trace[939401998] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"235.42037ms","start":"2026-10-06T10:05:06.781869Z","end":"2026-10-06T10:05:07.01729Z","steps":["trace[939401998] 'process raft request' (duration: 235.237654ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:06:00.561951Z","caller":"traceutil/trace.go:171","msg":"trace[1783960210] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"425.797271ms","start":"2026-10-06T10:06:00.136139Z","end":"2026-10-06T10:06:00.561936Z","steps":["trace[1783960210] 'read index received' (duration: 425.679107ms)","trace[1783960210] 'applied index is now lower than readState.Index' (duration: 117.674µs)"],"step_count":2} {"level":"info","ts":"2026-10-06T10:06:00.562105Z","caller":"traceutil/trace.go:171","msg":"trace[2057967479] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"427.731192ms","start":"2026-10-06T10:06:00.134368Z","end":"2026-10-06T10:06:00.562099Z","steps":["trace[2057967479] 'process raft request' (duration: 427.486835ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:06:00.562165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:06:00.134357Z","time spent":"427.761993ms","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-06T10:06:00.562316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.175483ms","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-06T10:06:00.562332Z","caller":"traceutil/trace.go:171","msg":"trace[1692958885] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1082; }","duration":"426.249935ms","start":"2026-10-06T10:06:00.136077Z","end":"2026-10-06T10:06:00.562327Z","steps":["trace[1692958885] 'agreement among raft nodes before linearized reading' (duration: 426.190513ms)"],"step_count":1} {"level":"warn","ts":"2026-10-06T10:06:00.562507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-06T10:06:00.136066Z","time spent":"426.438241ms","remote":"127.0.0.1:40436","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-06T10:06:00.56274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.059267ms","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-06T10:06:00.562811Z","caller":"traceutil/trace.go:171","msg":"trace[1428307196] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1082; }","duration":"291.175521ms","start":"2026-10-06T10:06:00.271616Z","end":"2026-10-06T10:06:00.562792Z","steps":["trace[1428307196] 'agreement among raft nodes before linearized reading' (duration: 290.953604ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:06:00.715377Z","caller":"traceutil/trace.go:171","msg":"trace[866957733] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"149.950073ms","start":"2026-10-06T10:06:00.56541Z","end":"2026-10-06T10:06:00.71536Z","steps":["trace[866957733] 'process raft request' (duration: 149.86023ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:06:00.716309Z","caller":"traceutil/trace.go:171","msg":"trace[1124684487] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"150.086518ms","start":"2026-10-06T10:06:00.566195Z","end":"2026-10-06T10:06:00.716281Z","steps":["trace[1124684487] 'process raft request' (duration: 149.969445ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:06:17.539181Z","caller":"traceutil/trace.go:171","msg":"trace[1229623628] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"171.06487ms","start":"2026-10-06T10:06:17.36809Z","end":"2026-10-06T10:06:17.539155Z","steps":["trace[1229623628] 'process raft request' (duration: 170.936566ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:06:18.703464Z","caller":"traceutil/trace.go:171","msg":"trace[212643029] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"100.307516ms","start":"2026-10-06T10:06:18.603132Z","end":"2026-10-06T10:06:18.70344Z","steps":["trace[212643029] 'process raft request' (duration: 31.236006ms)","trace[212643029] 'compare' (duration: 68.891995ms)"],"step_count":2} {"level":"warn","ts":"2026-10-06T10:06:19.024664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.478224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-06T10:06:19.024728Z","caller":"traceutil/trace.go:171","msg":"trace[2102123544] linearizableReadLoop","detail":"{readStateIndex:1213; appliedIndex:1212; }","duration":"213.382635ms","start":"2026-10-06T10:06:18.811335Z","end":"2026-10-06T10:06:19.024718Z","steps":["trace[2102123544] 'read index received' (duration: 91.760627ms)","trace[2102123544] 'applied index is now lower than readState.Index' (duration: 121.619768ms)"],"step_count":2} {"level":"info","ts":"2026-10-06T10:06:19.024839Z","caller":"traceutil/trace.go:171","msg":"trace[492459139] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"234.311666ms","start":"2026-10-06T10:06:18.790521Z","end":"2026-10-06T10:06:19.024833Z","steps":["trace[492459139] 'process raft request' (duration: 112.530192ms)","trace[492459139] 'compare' (duration: 121.412332ms)"],"step_count":2} {"level":"warn","ts":"2026-10-06T10:06:19.024996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.660784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-06T10:06:19.025013Z","caller":"traceutil/trace.go:171","msg":"trace[1115732457] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1169; }","duration":"213.713665ms","start":"2026-10-06T10:06:18.811295Z","end":"2026-10-06T10:06:19.025009Z","steps":["trace[1115732457] 'agreement among raft nodes before linearized reading' (duration: 213.630073ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:06:30.696039Z","caller":"traceutil/trace.go:171","msg":"trace[1983581345] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"129.506879ms","start":"2026-10-06T10:06:30.566507Z","end":"2026-10-06T10:06:30.696014Z","steps":["trace[1983581345] 'process raft request' (duration: 129.352044ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:06:31.0526Z","caller":"traceutil/trace.go:171","msg":"trace[1117077697] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"278.186579ms","start":"2026-10-06T10:06:30.774389Z","end":"2026-10-06T10:06:31.052576Z","steps":["trace[1117077697] 'process raft request' (duration: 275.785502ms)"],"step_count":1} {"level":"info","ts":"2026-10-06T10:06:31.081407Z","caller":"traceutil/trace.go:171","msg":"trace[1039360968] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1296; }","duration":"144.049262ms","start":"2026-10-06T10:06:30.937342Z","end":"2026-10-06T10:06:31.081391Z","steps":["trace[1039360968] 'read index received' (duration: 112.841225ms)","trace[1039360968] 'applied index is now lower than readState.Index' (duration: 31.207037ms)"],"step_count":2} {"level":"warn","ts":"2026-10-06T10:06:31.081579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.219937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-06T10:06:31.081658Z","caller":"traceutil/trace.go:171","msg":"trace[622481247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"144.335271ms","start":"2026-10-06T10:06:30.937302Z","end":"2026-10-06T10:06:31.081638Z","steps":["trace[622481247] 'agreement among raft nodes before linearized reading' (duration: 144.179226ms)"],"step_count":1}