{"level":"warn","ts":"2026-09-29T03:53:59.027965Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-29T03:53:59.028067Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.77: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.77:2380","--initial-cluster=instance=https://162.253.55.77:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.77:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.77:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-29T03:53:59.028204Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-29T03:53:59.028233Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.77:2380"]} {"level":"info","ts":"2026-09-29T03:53:59.028266Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-29T03:53:59.029029Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.77:2379"]} {"level":"info","ts":"2026-09-29T03:53:59.029223Z","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.77:2380"],"listen-peer-urls":["https://162.253.55.77:2380"],"advertise-client-urls":["https://162.253.55.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.77:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-29T03:53:59.039709Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.188823ms"} {"level":"info","ts":"2026-09-29T03:53:59.05003Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1e0199b9aba0b7bc","cluster-id":"f6bbdc6c581f37e5"} {"level":"info","ts":"2026-09-29T03:53:59.050115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc switched to configuration voters=()"} {"level":"info","ts":"2026-09-29T03:53:59.050248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc became follower at term 0"} {"level":"info","ts":"2026-09-29T03:53:59.050338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1e0199b9aba0b7bc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-29T03:53:59.050416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc became follower at term 1"} {"level":"info","ts":"2026-09-29T03:53:59.050547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc switched to configuration voters=(2162178318841984956)"} {"level":"warn","ts":"2026-09-29T03:53:59.059881Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-29T03:53:59.062225Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-29T03:53:59.064219Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-29T03:53:59.066838Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1e0199b9aba0b7bc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-29T03:53:59.066953Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1e0199b9aba0b7bc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-29T03:53:59.067364Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-29T03:53:59.067464Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-29T03:53:59.067474Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-29T03:53:59.069923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc switched to configuration voters=(2162178318841984956)"} {"level":"info","ts":"2026-09-29T03:53:59.070325Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f6bbdc6c581f37e5","local-member-id":"1e0199b9aba0b7bc","added-peer-id":"1e0199b9aba0b7bc","added-peer-peer-urls":["https://162.253.55.77:2380"]} {"level":"info","ts":"2026-09-29T03:53:59.072214Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-29T03:53:59.072448Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1e0199b9aba0b7bc","initial-advertise-peer-urls":["https://162.253.55.77:2380"],"listen-peer-urls":["https://162.253.55.77:2380"],"advertise-client-urls":["https://162.253.55.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-29T03:53:59.072475Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-29T03:53:59.072613Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.77:2380"} {"level":"info","ts":"2026-09-29T03:53:59.072666Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.77:2380"} {"level":"info","ts":"2026-09-29T03:53:59.651419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc is starting a new election at term 1"} {"level":"info","ts":"2026-09-29T03:53:59.651463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc became pre-candidate at term 1"} {"level":"info","ts":"2026-09-29T03:53:59.651494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc received MsgPreVoteResp from 1e0199b9aba0b7bc at term 1"} {"level":"info","ts":"2026-09-29T03:53:59.651506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc became candidate at term 2"} {"level":"info","ts":"2026-09-29T03:53:59.651513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc received MsgVoteResp from 1e0199b9aba0b7bc at term 2"} {"level":"info","ts":"2026-09-29T03:53:59.651538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc became leader at term 2"} {"level":"info","ts":"2026-09-29T03:53:59.65155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1e0199b9aba0b7bc elected leader 1e0199b9aba0b7bc at term 2"} {"level":"info","ts":"2026-09-29T03:53:59.652605Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:53:59.653359Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1e0199b9aba0b7bc","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.77:2379]}","request-path":"/0/members/1e0199b9aba0b7bc/attributes","cluster-id":"f6bbdc6c581f37e5","publish-timeout":"7s"} {"level":"info","ts":"2026-09-29T03:53:59.653473Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T03:53:59.653548Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T03:53:59.654045Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f6bbdc6c581f37e5","local-member-id":"1e0199b9aba0b7bc","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:53:59.654203Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:53:59.654243Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:53:59.655031Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.77:2379"} {"level":"info","ts":"2026-09-29T03:53:59.655158Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-29T03:53:59.655169Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-29T03:53:59.656401Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-29T03:54:01.460128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.06334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-29T03:54:01.460243Z","caller":"traceutil/trace.go:171","msg":"trace[1969240456] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"316.327679ms","start":"2026-09-29T03:54:01.143896Z","end":"2026-09-29T03:54:01.460224Z","steps":["trace[1969240456] 'process raft request' (duration: 150.656813ms)","trace[1969240456] 'compare' (duration: 164.907316ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:54:01.460366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.143874Z","time spent":"316.409451ms","remote":"127.0.0.1:45964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-29T03:54:01.725885Z","caller":"traceutil/trace.go:171","msg":"trace[1903687740] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"581.402881ms","start":"2026-09-29T03:54:01.144444Z","end":"2026-09-29T03:54:01.725846Z","steps":["trace[1903687740] 'process raft request' (duration: 581.258078ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.725951Z","caller":"traceutil/trace.go:171","msg":"trace[447402224] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"581.865743ms","start":"2026-09-29T03:54:01.144075Z","end":"2026-09-29T03:54:01.725941Z","steps":["trace[447402224] 'process raft request' (duration: 581.35354ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.725941Z","caller":"traceutil/trace.go:171","msg":"trace[1557084889] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:6; }","duration":"581.434862ms","start":"2026-09-29T03:54:01.14448Z","end":"2026-09-29T03:54:01.725915Z","steps":["trace[1557084889] 'read index received' (duration: 150.11385ms)","trace[1557084889] 'applied index is now lower than readState.Index' (duration: 431.319312ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:54:01.726054Z","caller":"traceutil/trace.go:171","msg":"trace[1522618200] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"567.556888ms","start":"2026-09-29T03:54:01.158487Z","end":"2026-09-29T03:54:01.726044Z","steps":["trace[1522618200] 'process raft request' (duration: 567.285491ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:01.726045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.144065Z","time spent":"581.925504ms","remote":"127.0.0.1:46068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T03:54:01.726045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.144434Z","time spent":"581.555655ms","remote":"127.0.0.1:46068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T03:54:01.726141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.158474Z","time spent":"567.60661ms","remote":"127.0.0.1:45690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-29T03:54:01.726213Z","caller":"traceutil/trace.go:171","msg":"trace[511837987] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"574.910041ms","start":"2026-09-29T03:54:01.151249Z","end":"2026-09-29T03:54:01.726159Z","steps":["trace[511837987] 'process raft request' (duration: 574.47872ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.725897Z","caller":"traceutil/trace.go:171","msg":"trace[1624701272] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"581.609317ms","start":"2026-09-29T03:54:01.144248Z","end":"2026-09-29T03:54:01.725857Z","steps":["trace[1624701272] 'process raft request' (duration: 581.34142ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:01.726337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.151237Z","time spent":"575.043294ms","remote":"127.0.0.1:45770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-29T03:54:01.726353Z","caller":"traceutil/trace.go:171","msg":"trace[1111746839] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"581.939495ms","start":"2026-09-29T03:54:01.144394Z","end":"2026-09-29T03:54:01.726334Z","steps":["trace[1111746839] 'process raft request' (duration: 581.260737ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.726443Z","caller":"traceutil/trace.go:171","msg":"trace[721067433] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"581.963145ms","start":"2026-09-29T03:54:01.14439Z","end":"2026-09-29T03:54:01.726353Z","steps":["trace[721067433] 'process raft request' (duration: 581.244267ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:01.726507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.144377Z","time spent":"582.023476ms","remote":"127.0.0.1:46068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T03:54:01.726349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.144239Z","time spent":"582.070978ms","remote":"127.0.0.1:46068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T03:54:01.726596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.144379Z","time spent":"582.126059ms","remote":"127.0.0.1:46068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T03:54:01.726814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.294463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-29T03:54:01.726854Z","caller":"traceutil/trace.go:171","msg":"trace[711567957] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"582.384095ms","start":"2026-09-29T03:54:01.144457Z","end":"2026-09-29T03:54:01.726841Z","steps":["trace[711567957] 'agreement among raft nodes before linearized reading' (duration: 582.238232ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:01.726882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.144446Z","time spent":"582.428437ms","remote":"127.0.0.1:45614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-09-29T03:54:01.947854Z","caller":"traceutil/trace.go:171","msg":"trace[205213907] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"221.820154ms","start":"2026-09-29T03:54:01.726012Z","end":"2026-09-29T03:54:01.947832Z","steps":["trace[205213907] 'read index received' (duration: 220.705186ms)","trace[205213907] 'applied index is now lower than readState.Index' (duration: 1.113808ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:54:01.94788Z","caller":"traceutil/trace.go:171","msg":"trace[1116676060] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"484.129006ms","start":"2026-09-29T03:54:01.463724Z","end":"2026-09-29T03:54:01.947853Z","steps":["trace[1116676060] 'process raft request' (duration: 482.921656ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:01.948009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.064197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-29T03:54:01.948045Z","caller":"traceutil/trace.go:171","msg":"trace[1507998384] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"798.133489ms","start":"2026-09-29T03:54:01.149901Z","end":"2026-09-29T03:54:01.948035Z","steps":["trace[1507998384] 'agreement among raft nodes before linearized reading' (duration: 798.028286ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:01.948077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.149892Z","time spent":"798.17624ms","remote":"127.0.0.1:45916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-09-29T03:54:01.948228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.463703Z","time spent":"484.427854ms","remote":"127.0.0.1:45964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T03:54:01.948233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.114847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-29T03:54:01.948494Z","caller":"traceutil/trace.go:171","msg":"trace[312375444] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"751.471896ms","start":"2026-09-29T03:54:01.196989Z","end":"2026-09-29T03:54:01.948461Z","steps":["trace[312375444] 'agreement among raft nodes before linearized reading' (duration: 750.887491ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:01.948569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.30054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-29T03:54:01.948474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.45803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-29T03:54:01.948642Z","caller":"traceutil/trace.go:171","msg":"trace[2145885711] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:12; }","duration":"615.401463ms","start":"2026-09-29T03:54:01.333221Z","end":"2026-09-29T03:54:01.948623Z","steps":["trace[2145885711] 'agreement among raft nodes before linearized reading' (duration: 615.28016ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:01.948688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.333203Z","time spent":"615.476715ms","remote":"127.0.0.1:45784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-09-29T03:54:01.948718Z","caller":"traceutil/trace.go:171","msg":"trace[849624359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"803.719016ms","start":"2026-09-29T03:54:01.14493Z","end":"2026-09-29T03:54:01.948649Z","steps":["trace[849624359] 'agreement among raft nodes before linearized reading' (duration: 803.328447ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:01.948828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.144899Z","time spent":"803.86398ms","remote":"127.0.0.1:45516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-29T03:54:01.948924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:01.196969Z","time spent":"751.939168ms","remote":"127.0.0.1:45636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-09-29T03:54:01.954751Z","caller":"traceutil/trace.go:171","msg":"trace[1315619695] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"224.525969ms","start":"2026-09-29T03:54:01.730205Z","end":"2026-09-29T03:54:01.954731Z","steps":["trace[1315619695] 'process raft request' (duration: 224.367556ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.954854Z","caller":"traceutil/trace.go:171","msg":"trace[449293748] transaction","detail":"{read_only:false; number_of_response:0; response_revision:14; }","duration":"223.679078ms","start":"2026-09-29T03:54:01.731162Z","end":"2026-09-29T03:54:01.954841Z","steps":["trace[449293748] 'process raft request' (duration: 223.445144ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.954961Z","caller":"traceutil/trace.go:171","msg":"trace[2004370582] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"225.058542ms","start":"2026-09-29T03:54:01.729893Z","end":"2026-09-29T03:54:01.954951Z","steps":["trace[2004370582] 'process raft request' (duration: 224.586551ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.95506Z","caller":"traceutil/trace.go:171","msg":"trace[938631275] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"222.992122ms","start":"2026-09-29T03:54:01.732055Z","end":"2026-09-29T03:54:01.955047Z","steps":["trace[938631275] 'process raft request' (duration: 222.587272ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.955161Z","caller":"traceutil/trace.go:171","msg":"trace[1862856752] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"222.706884ms","start":"2026-09-29T03:54:01.732446Z","end":"2026-09-29T03:54:01.955153Z","steps":["trace[1862856752] 'process raft request' (duration: 222.238132ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:01.955458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.842712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-pmn27\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-09-29T03:54:01.955503Z","caller":"traceutil/trace.go:171","msg":"trace[2139714741] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-pmn27; range_end:; response_count:1; response_revision:19; }","duration":"223.947436ms","start":"2026-09-29T03:54:01.731545Z","end":"2026-09-29T03:54:01.955493Z","steps":["trace[2139714741] 'agreement among raft nodes before linearized reading' (duration: 223.814332ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.955652Z","caller":"traceutil/trace.go:171","msg":"trace[611068226] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"223.015893ms","start":"2026-09-29T03:54:01.732627Z","end":"2026-09-29T03:54:01.955642Z","steps":["trace[611068226] 'process raft request' (duration: 222.076539ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.955773Z","caller":"traceutil/trace.go:171","msg":"trace[1898183207] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"216.270146ms","start":"2026-09-29T03:54:01.739494Z","end":"2026-09-29T03:54:01.955764Z","steps":["trace[1898183207] 'process raft request' (duration: 215.277321ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:01.955937Z","caller":"traceutil/trace.go:171","msg":"trace[140071480] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"223.136966ms","start":"2026-09-29T03:54:01.732782Z","end":"2026-09-29T03:54:01.955919Z","steps":["trace[140071480] 'process raft request' (duration: 221.956846ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:36.506324Z","caller":"traceutil/trace.go:171","msg":"trace[1868584725] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"126.953509ms","start":"2026-09-29T03:54:36.379327Z","end":"2026-09-29T03:54:36.506281Z","steps":["trace[1868584725] 'process raft request' (duration: 126.767504ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:45.587335Z","caller":"traceutil/trace.go:171","msg":"trace[1370841192] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"180.083922ms","start":"2026-09-29T03:54:45.406995Z","end":"2026-09-29T03:54:45.587079Z","steps":["trace[1370841192] 'process raft request' (duration: 179.069776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:46.413287Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13239633937019703065,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-29T03:54:46.467227Z","caller":"traceutil/trace.go:171","msg":"trace[806708032] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"554.64216ms","start":"2026-09-29T03:54:45.912564Z","end":"2026-09-29T03:54:46.467206Z","steps":["trace[806708032] 'read index received' (duration: 545.528025ms)","trace[806708032] 'applied index is now lower than readState.Index' (duration: 9.113225ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:54:46.467337Z","caller":"traceutil/trace.go:171","msg":"trace[1024031883] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"797.671098ms","start":"2026-09-29T03:54:45.669657Z","end":"2026-09-29T03:54:46.467328Z","steps":["trace[1024031883] 'process raft request' (duration: 788.47657ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:46.467406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:45.669634Z","time spent":"797.724938ms","remote":"127.0.0.1:46040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-29T03:54:46.467757Z","caller":"traceutil/trace.go:171","msg":"trace[1475501367] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"582.361585ms","start":"2026-09-29T03:54:45.885335Z","end":"2026-09-29T03:54:46.467697Z","steps":["trace[1475501367] 'process raft request' (duration: 581.806202ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:46.468161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.519867ms","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-09-29T03:54:46.468236Z","caller":"traceutil/trace.go:171","msg":"trace[2039276169] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"533.62927ms","start":"2026-09-29T03:54:45.934586Z","end":"2026-09-29T03:54:46.468215Z","steps":["trace[2039276169] 'agreement among raft nodes before linearized reading' (duration: 533.141267ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:46.468287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:45.934567Z","time spent":"533.707112ms","remote":"127.0.0.1:45784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-29T03:54:46.46845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:45.885314Z","time spent":"582.687823ms","remote":"127.0.0.1:45784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T03:54:46.468638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.064995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-85xzf\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-29T03:54:46.4687Z","caller":"traceutil/trace.go:171","msg":"trace[1658905621] range","detail":"{range_begin:/registry/pods/kube-system/cilium-85xzf; range_end:; response_count:1; response_revision:599; }","duration":"556.185467ms","start":"2026-09-29T03:54:45.912499Z","end":"2026-09-29T03:54:46.468684Z","steps":["trace[1658905621] 'agreement among raft nodes before linearized reading' (duration: 554.972178ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:46.468738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:54:45.912479Z","time spent":"556.24916ms","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-85xzf\" "} {"level":"info","ts":"2026-09-29T03:54:48.218454Z","caller":"traceutil/trace.go:171","msg":"trace[1694695900] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"159.328308ms","start":"2026-09-29T03:54:48.059097Z","end":"2026-09-29T03:54:48.218425Z","steps":["trace[1694695900] 'process raft request' (duration: 139.830696ms)","trace[1694695900] 'compare' (duration: 19.336348ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:55:42.985906Z","caller":"traceutil/trace.go:171","msg":"trace[923547281] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1084; }","duration":"128.442705ms","start":"2026-09-29T03:55:42.857442Z","end":"2026-09-29T03:55:42.985884Z","steps":["trace[923547281] 'read index received' (duration: 128.235579ms)","trace[923547281] 'applied index is now lower than readState.Index' (duration: 206.026µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:55:42.986028Z","caller":"traceutil/trace.go:171","msg":"trace[1706520979] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"199.225305ms","start":"2026-09-29T03:55:42.786792Z","end":"2026-09-29T03:55:42.986018Z","steps":["trace[1706520979] 'process raft request' (duration: 198.926997ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:55:42.986269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.819114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.77\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-29T03:55:42.986299Z","caller":"traceutil/trace.go:171","msg":"trace[1785498207] range","detail":"{range_begin:/registry/masterleases/162.253.55.77; range_end:; response_count:1; response_revision:1047; }","duration":"128.884636ms","start":"2026-09-29T03:55:42.857404Z","end":"2026-09-29T03:55:42.986289Z","steps":["trace[1785498207] 'agreement among raft nodes before linearized reading' (duration: 128.732522ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:55:43.201246Z","caller":"traceutil/trace.go:171","msg":"trace[265201846] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"211.053906ms","start":"2026-09-29T03:55:42.990168Z","end":"2026-09-29T03:55:43.201222Z","steps":["trace[265201846] 'process raft request' (duration: 210.767769ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:55:43.201262Z","caller":"traceutil/trace.go:171","msg":"trace[246541341] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"210.687158ms","start":"2026-09-29T03:55:42.990559Z","end":"2026-09-29T03:55:43.201246Z","steps":["trace[246541341] 'process raft request' (duration: 210.517504ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:55:43.201743Z","caller":"traceutil/trace.go:171","msg":"trace[1532184431] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"210.621266ms","start":"2026-09-29T03:55:42.990575Z","end":"2026-09-29T03:55:43.201197Z","steps":["trace[1532184431] 'process raft request' (duration: 210.575234ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:56:00.355321Z","caller":"traceutil/trace.go:171","msg":"trace[950246628] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"159.40076ms","start":"2026-09-29T03:56:00.195895Z","end":"2026-09-29T03:56:00.355296Z","steps":["trace[950246628] 'process raft request' (duration: 159.286257ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:56:00.769131Z","caller":"traceutil/trace.go:171","msg":"trace[1090117535] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1167; }","duration":"488.346701ms","start":"2026-09-29T03:56:00.280762Z","end":"2026-09-29T03:56:00.769108Z","steps":["trace[1090117535] 'read index received' (duration: 74.41807ms)","trace[1090117535] 'applied index is now lower than readState.Index' (duration: 413.914371ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:56:00.769201Z","caller":"traceutil/trace.go:171","msg":"trace[115553705] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"572.821299ms","start":"2026-09-29T03:56:00.196374Z","end":"2026-09-29T03:56:00.769195Z","steps":["trace[115553705] 'process raft request' (duration: 572.606343ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:56:00.769274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:56:00.196352Z","time spent":"572.86343ms","remote":"127.0.0.1:45784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T03:56:00.769391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.605398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T03:56:00.769466Z","caller":"traceutil/trace.go:171","msg":"trace[244945078] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1127; }","duration":"488.724421ms","start":"2026-09-29T03:56:00.280721Z","end":"2026-09-29T03:56:00.769445Z","steps":["trace[244945078] 'agreement among raft nodes before linearized reading' (duration: 488.546676ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:56:00.769505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:56:00.280696Z","time spent":"488.801753ms","remote":"127.0.0.1:45784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-09-29T03:56:00.779009Z","caller":"traceutil/trace.go:171","msg":"trace[2073680640] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"189.897673ms","start":"2026-09-29T03:56:00.58909Z","end":"2026-09-29T03:56:00.778988Z","steps":["trace[2073680640] 'process raft request' (duration: 189.800201ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:56:00.779111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.580776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-29T03:56:00.779141Z","caller":"traceutil/trace.go:171","msg":"trace[1848865843] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1128; }","duration":"384.655367ms","start":"2026-09-29T03:56:00.394477Z","end":"2026-09-29T03:56:00.779132Z","steps":["trace[1848865843] 'agreement among raft nodes before linearized reading' (duration: 384.520584ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:56:00.779166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:56:00.394453Z","time spent":"384.707669ms","remote":"127.0.0.1:45784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-29T03:56:01.489918Z","caller":"traceutil/trace.go:171","msg":"trace[567397975] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"175.94898ms","start":"2026-09-29T03:56:01.313913Z","end":"2026-09-29T03:56:01.489862Z","steps":["trace[567397975] 'process raft request' (duration: 104.737799ms)","trace[567397975] 'compare' (duration: 71.052607ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:56:22.201127Z","caller":"traceutil/trace.go:171","msg":"trace[1808782864] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"125.573984ms","start":"2026-09-29T03:56:22.07553Z","end":"2026-09-29T03:56:22.201104Z","steps":["trace[1808782864] 'process raft request' (duration: 125.443081ms)"],"step_count":1}