{"level":"warn","ts":"2026-10-14T19:41:36.35488Z","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-14T19:41:36.354973Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.218: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.218:2380","--initial-cluster=instance=https://162.253.55.218:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.218:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.218: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-14T19:41:36.355185Z","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-14T19:41:36.355202Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-10-14T19:41:36.355238Z","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-14T19:41:36.355935Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"]} {"level":"info","ts":"2026-10-14T19:41:36.356018Z","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.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.218: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-14T19:41:36.358957Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.751954ms"} {"level":"info","ts":"2026-10-14T19:41:36.365049Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bb7d59f4041c8abe","cluster-id":"5330ca29224af3c4"} {"level":"info","ts":"2026-10-14T19:41:36.365117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T19:41:36.365131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 0"} {"level":"info","ts":"2026-10-14T19:41:36.365137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bb7d59f4041c8abe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T19:41:36.365146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 1"} {"level":"info","ts":"2026-10-14T19:41:36.365173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"warn","ts":"2026-10-14T19:41:36.371721Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T19:41:36.373305Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T19:41:36.37465Z","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-14T19:41:36.377087Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bb7d59f4041c8abe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T19:41:36.37725Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bb7d59f4041c8abe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T19:41:36.377415Z","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-14T19:41:36.377624Z","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-14T19:41:36.377687Z","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-14T19:41:36.379158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"info","ts":"2026-10-14T19:41:36.379715Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","added-peer-id":"bb7d59f4041c8abe","added-peer-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-10-14T19:41:36.3816Z","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-14T19:41:36.381707Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-10-14T19:41:36.381762Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-10-14T19:41:36.381846Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bb7d59f4041c8abe","initial-advertise-peer-urls":["https://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T19:41:36.381943Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T19:41:36.566106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T19:41:36.566198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T19:41:36.566224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgPreVoteResp from bb7d59f4041c8abe at term 1"} {"level":"info","ts":"2026-10-14T19:41:36.566243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became candidate at term 2"} {"level":"info","ts":"2026-10-14T19:41:36.566251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgVoteResp from bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-10-14T19:41:36.566263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became leader at term 2"} {"level":"info","ts":"2026-10-14T19:41:36.566274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bb7d59f4041c8abe elected leader bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-10-14T19:41:36.567825Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T19:41:36.569318Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T19:41:36.569393Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T19:41:36.569421Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T19:41:36.569446Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T19:41:36.569464Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bb7d59f4041c8abe","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.218:2379]}","request-path":"/0/members/bb7d59f4041c8abe/attributes","cluster-id":"5330ca29224af3c4","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T19:41:36.569803Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T19:41:36.569936Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T19:41:36.569987Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T19:41:36.572978Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-14T19:41:36.577489Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.218:2379"} {"level":"info","ts":"2026-10-14T19:41:39.587845Z","caller":"traceutil/trace.go:171","msg":"trace[1660622236] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"173.592905ms","start":"2026-10-14T19:41:39.414224Z","end":"2026-10-14T19:41:39.587817Z","steps":["trace[1660622236] 'read index received' (duration: 173.422041ms)","trace[1660622236] 'applied index is now lower than readState.Index' (duration: 169.954µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:41:39.587952Z","caller":"traceutil/trace.go:171","msg":"trace[668340093] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"174.322711ms","start":"2026-10-14T19:41:39.413585Z","end":"2026-10-14T19:41:39.587908Z","steps":["trace[668340093] 'process raft request' (duration: 174.104546ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:41:39.5881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.855611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-14T19:41:39.588167Z","caller":"traceutil/trace.go:171","msg":"trace[743040739] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:72; }","duration":"173.941563ms","start":"2026-10-14T19:41:39.414212Z","end":"2026-10-14T19:41:39.588153Z","steps":["trace[743040739] 'agreement among raft nodes before linearized reading' (duration: 173.762879ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:41:41.878532Z","caller":"traceutil/trace.go:171","msg":"trace[128350767] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"104.406379ms","start":"2026-10-14T19:41:41.774067Z","end":"2026-10-14T19:41:41.878474Z","steps":["trace[128350767] 'process raft request' (duration: 104.173183ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:41:42.397069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.371347ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-14T19:41:42.397184Z","caller":"traceutil/trace.go:171","msg":"trace[1037117989] linearizableReadLoop","detail":"{readStateIndex:284; appliedIndex:283; }","duration":"476.812187ms","start":"2026-10-14T19:41:41.920352Z","end":"2026-10-14T19:41:42.397164Z","steps":["trace[1037117989] 'read index received' (duration: 157.729544ms)","trace[1037117989] 'applied index is now lower than readState.Index' (duration: 319.080762ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:41:42.397399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.024791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-10-14T19:41:42.397486Z","caller":"traceutil/trace.go:171","msg":"trace[1423359611] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:277; }","duration":"477.139925ms","start":"2026-10-14T19:41:41.920326Z","end":"2026-10-14T19:41:42.397466Z","steps":["trace[1423359611] 'agreement among raft nodes before linearized reading' (duration: 476.94958ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:41:42.397531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:41.920312Z","time spent":"477.211516ms","remote":"127.0.0.1:38988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-10-14T19:41:42.397937Z","caller":"traceutil/trace.go:171","msg":"trace[2064321297] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"507.547304ms","start":"2026-10-14T19:41:41.890363Z","end":"2026-10-14T19:41:42.39791Z","steps":["trace[2064321297] 'process raft request' (duration: 187.54496ms)","trace[2064321297] 'compare' (duration: 318.067459ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:41:42.398091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:41.890338Z","time spent":"507.650477ms","remote":"127.0.0.1:56902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":597,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T19:41:42.437104Z","caller":"traceutil/trace.go:171","msg":"trace[1351149872] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"516.238448ms","start":"2026-10-14T19:41:41.920839Z","end":"2026-10-14T19:41:42.437077Z","steps":["trace[1351149872] 'process raft request' (duration: 516.045773ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:41:42.437154Z","caller":"traceutil/trace.go:171","msg":"trace[179541641] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"508.016445ms","start":"2026-10-14T19:41:41.92912Z","end":"2026-10-14T19:41:42.437136Z","steps":["trace[179541641] 'process raft request' (duration: 507.855151ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:41:42.437305Z","caller":"traceutil/trace.go:171","msg":"trace[1802215514] transaction","detail":"{read_only:false; number_of_response:0; response_revision:279; }","duration":"422.407866ms","start":"2026-10-14T19:41:42.014873Z","end":"2026-10-14T19:41:42.437281Z","steps":["trace[1802215514] 'process raft request' (duration: 422.172841ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:41:42.437358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:41.920819Z","time spent":"516.36151ms","remote":"127.0.0.1:56878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T19:41:42.437435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:42.014826Z","time spent":"422.549159ms","remote":"127.0.0.1:56974","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-10-14T19:41:42.437465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:41.929104Z","time spent":"508.093047ms","remote":"127.0.0.1:57008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":180,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T19:41:42.437845Z","caller":"traceutil/trace.go:171","msg":"trace[1571390415] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"377.990168ms","start":"2026-10-14T19:41:42.059835Z","end":"2026-10-14T19:41:42.437825Z","steps":["trace[1571390415] 'process raft request' (duration: 377.459056ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:41:42.437989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:42.059819Z","time spent":"378.06905ms","remote":"127.0.0.1:56984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T19:41:42.437992Z","caller":"traceutil/trace.go:171","msg":"trace[1866558712] transaction","detail":"{read_only:false; number_of_response:0; response_revision:280; }","duration":"378.015669ms","start":"2026-10-14T19:41:42.059963Z","end":"2026-10-14T19:41:42.437979Z","steps":["trace[1866558712] 'process raft request' (duration: 377.785403ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:41:42.438282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:42.059955Z","time spent":"378.286165ms","remote":"127.0.0.1:56984","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-10-14T19:41:42.438056Z","caller":"traceutil/trace.go:171","msg":"trace[1415650640] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"377.489866ms","start":"2026-10-14T19:41:42.060557Z","end":"2026-10-14T19:41:42.438047Z","steps":["trace[1415650640] 'process raft request' (duration: 377.356503ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:41:42.438392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:42.060549Z","time spent":"377.823074ms","remote":"127.0.0.1:56984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T19:41:42.438112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.619829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:41:42.438507Z","caller":"traceutil/trace.go:171","msg":"trace[174809929] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:283; }","duration":"518.0279ms","start":"2026-10-14T19:41:41.920465Z","end":"2026-10-14T19:41:42.438493Z","steps":["trace[174809929] 'agreement among raft nodes before linearized reading' (duration: 517.60534ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:41:42.43856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:41.920459Z","time spent":"518.075291ms","remote":"127.0.0.1:57078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-10-14T19:41:42.438108Z","caller":"traceutil/trace.go:171","msg":"trace[1984317183] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"377.599929ms","start":"2026-10-14T19:41:42.060445Z","end":"2026-10-14T19:41:42.438045Z","steps":["trace[1984317183] 'process raft request' (duration: 377.409455ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:41:42.438647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:42.060436Z","time spent":"378.188783ms","remote":"127.0.0.1:56984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T19:41:42.438152Z","caller":"traceutil/trace.go:171","msg":"trace[935867810] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"377.949787ms","start":"2026-10-14T19:41:42.060193Z","end":"2026-10-14T19:41:42.438143Z","steps":["trace[935867810] 'process raft request' (duration: 377.604029ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:41:42.438747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:41:42.060183Z","time spent":"378.525071ms","remote":"127.0.0.1:56984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T19:42:27.222226Z","caller":"traceutil/trace.go:171","msg":"trace[2137892813] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"175.612149ms","start":"2026-10-14T19:42:27.046585Z","end":"2026-10-14T19:42:27.222198Z","steps":["trace[2137892813] 'process raft request' (duration: 91.50885ms)","trace[2137892813] 'compare' (duration: 83.820022ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:42:27.394398Z","caller":"traceutil/trace.go:171","msg":"trace[590757547] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"149.550542ms","start":"2026-10-14T19:42:27.244762Z","end":"2026-10-14T19:42:27.394312Z","steps":["trace[590757547] 'process raft request' (duration: 124.419767ms)","trace[590757547] 'compare' (duration: 24.799537ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:42:27.988573Z","caller":"traceutil/trace.go:171","msg":"trace[190431002] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"169.664464ms","start":"2026-10-14T19:42:27.818825Z","end":"2026-10-14T19:42:27.988489Z","steps":["trace[190431002] 'read index received' (duration: 165.032631ms)","trace[190431002] 'applied index is now lower than readState.Index' (duration: 4.630443ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:42:27.989197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.32936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:42:27.989238Z","caller":"traceutil/trace.go:171","msg":"trace[1494753322] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"309.606589ms","start":"2026-10-14T19:42:27.679586Z","end":"2026-10-14T19:42:27.989193Z","steps":["trace[1494753322] 'process raft request' (duration: 307.19942ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:27.989298Z","caller":"traceutil/trace.go:171","msg":"trace[744783597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"170.510824ms","start":"2026-10-14T19:42:27.818759Z","end":"2026-10-14T19:42:27.98927Z","steps":["trace[744783597] 'agreement among raft nodes before linearized reading' (duration: 170.257708ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:27.989977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:42:27.67955Z","time spent":"309.743553ms","remote":"127.0.0.1:56888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T19:42:42.332343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.23275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-14T19:42:42.33243Z","caller":"traceutil/trace.go:171","msg":"trace[2043205759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:810; }","duration":"271.379564ms","start":"2026-10-14T19:42:42.061032Z","end":"2026-10-14T19:42:42.332412Z","steps":["trace[2043205759] 'range keys from in-memory index tree' (duration: 271.057736ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:42.555412Z","caller":"traceutil/trace.go:171","msg":"trace[1960535475] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"218.954791ms","start":"2026-10-14T19:42:42.336434Z","end":"2026-10-14T19:42:42.555389Z","steps":["trace[1960535475] 'process raft request' (duration: 218.826447ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:42.705089Z","caller":"traceutil/trace.go:171","msg":"trace[258335133] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"365.692532ms","start":"2026-10-14T19:42:42.339313Z","end":"2026-10-14T19:42:42.705005Z","steps":["trace[258335133] 'process raft request' (duration: 365.440566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:42.705629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:42:42.339301Z","time spent":"366.120413ms","remote":"127.0.0.1:56984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T19:43:23.252779Z","caller":"traceutil/trace.go:171","msg":"trace[1708894049] linearizableReadLoop","detail":"{readStateIndex:1137; appliedIndex:1136; }","duration":"434.18938ms","start":"2026-10-14T19:43:22.818568Z","end":"2026-10-14T19:43:23.252757Z","steps":["trace[1708894049] 'read index received' (duration: 434.002955ms)","trace[1708894049] 'applied index is now lower than readState.Index' (duration: 185.905µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:43:23.252814Z","caller":"traceutil/trace.go:171","msg":"trace[1537004909] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"488.559141ms","start":"2026-10-14T19:43:22.764242Z","end":"2026-10-14T19:43:23.252801Z","steps":["trace[1537004909] 'process raft request' (duration: 488.345845ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:43:23.252881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.303053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:43:23.252909Z","caller":"traceutil/trace.go:171","msg":"trace[1509306427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1093; }","duration":"434.347054ms","start":"2026-10-14T19:43:22.818555Z","end":"2026-10-14T19:43:23.252902Z","steps":["trace[1509306427] 'agreement among raft nodes before linearized reading' (duration: 434.282032ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:43:23.252936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:43:22.818518Z","time spent":"434.409316ms","remote":"127.0.0.1:56822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-14T19:43:23.252983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:43:22.764226Z","time spent":"488.668234ms","remote":"127.0.0.1:57078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T19:43:38.477743Z","caller":"traceutil/trace.go:171","msg":"trace[276945766] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"126.782657ms","start":"2026-10-14T19:43:38.350937Z","end":"2026-10-14T19:43:38.47772Z","steps":["trace[276945766] 'process raft request' (duration: 126.668724ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:43:39.685128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.958883ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T19:43:39.685535Z","caller":"traceutil/trace.go:171","msg":"trace[1448096968] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"179.159793ms","start":"2026-10-14T19:43:39.506356Z","end":"2026-10-14T19:43:39.685516Z","steps":["trace[1448096968] 'process raft request' (duration: 77.73213ms)","trace[1448096968] 'compare' (duration: 100.87517ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:43:39.685771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.161009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-14T19:43:39.685801Z","caller":"traceutil/trace.go:171","msg":"trace[892429565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1150; }","duration":"249.232ms","start":"2026-10-14T19:43:39.43656Z","end":"2026-10-14T19:43:39.685792Z","steps":["trace[892429565] 'range keys from in-memory index tree' (duration: 247.845538ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:43:39.905763Z","caller":"traceutil/trace.go:171","msg":"trace[983995152] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"215.130879ms","start":"2026-10-14T19:43:39.690602Z","end":"2026-10-14T19:43:39.905733Z","steps":["trace[983995152] 'process raft request' (duration: 171.359828ms)","trace[983995152] 'compare' (duration: 43.643818ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:43:39.908504Z","caller":"traceutil/trace.go:171","msg":"trace[700128535] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"217.491676ms","start":"2026-10-14T19:43:39.690997Z","end":"2026-10-14T19:43:39.908489Z","steps":["trace[700128535] 'process raft request' (duration: 217.330642ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:43:39.90986Z","caller":"traceutil/trace.go:171","msg":"trace[471653234] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"153.559014ms","start":"2026-10-14T19:43:39.755329Z","end":"2026-10-14T19:43:39.908888Z","steps":["trace[471653234] 'process raft request' (duration: 153.127084ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:43:53.59204Z","caller":"traceutil/trace.go:171","msg":"trace[1104338408] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"174.092502ms","start":"2026-10-14T19:43:53.417916Z","end":"2026-10-14T19:43:53.592008Z","steps":["trace[1104338408] 'process raft request' (duration: 173.829426ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:47:04.152973Z","caller":"traceutil/trace.go:171","msg":"trace[1486502229] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"126.581879ms","start":"2026-10-14T19:47:04.026365Z","end":"2026-10-14T19:47:04.152947Z","steps":["trace[1486502229] 'process raft request' (duration: 126.453326ms)"],"step_count":1}