{"level":"warn","ts":"2026-09-01T00:35:39.74722Z","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-01T00:35:39.74733Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.116: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.116:2380","--initial-cluster=instance=https://162.253.55.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.116: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-01T00:35:39.747424Z","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-01T00:35:39.747438Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.116:2380"]} {"level":"info","ts":"2026-09-01T00:35:39.747465Z","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-01T00:35:39.748342Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.116:2379"]} {"level":"info","ts":"2026-09-01T00:35:39.748472Z","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.116:2380"],"listen-peer-urls":["https://162.253.55.116:2380"],"advertise-client-urls":["https://162.253.55.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.116: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-01T00:35:39.753703Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.924311ms"} {"level":"info","ts":"2026-09-01T00:35:39.762336Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9755887b76c83964","cluster-id":"5ee78cd75a03071"} {"level":"info","ts":"2026-09-01T00:35:39.762434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T00:35:39.762462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became follower at term 0"} {"level":"info","ts":"2026-09-01T00:35:39.76248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9755887b76c83964 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T00:35:39.76249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became follower at term 1"} {"level":"info","ts":"2026-09-01T00:35:39.76254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 switched to configuration voters=(10904772136602712420)"} {"level":"warn","ts":"2026-09-01T00:35:39.768336Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T00:35:39.770141Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T00:35:39.772119Z","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-01T00:35:39.77423Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9755887b76c83964","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T00:35:39.774418Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9755887b76c83964","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T00:35:39.774662Z","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-01T00:35:39.774813Z","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-01T00:35:39.77483Z","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-01T00:35:39.776372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 switched to configuration voters=(10904772136602712420)"} {"level":"info","ts":"2026-09-01T00:35:39.776532Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5ee78cd75a03071","local-member-id":"9755887b76c83964","added-peer-id":"9755887b76c83964","added-peer-peer-urls":["https://162.253.55.116:2380"]} {"level":"info","ts":"2026-09-01T00:35:39.778463Z","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-01T00:35:39.778658Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.116:2380"} {"level":"info","ts":"2026-09-01T00:35:39.778706Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.116:2380"} {"level":"info","ts":"2026-09-01T00:35:39.778746Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9755887b76c83964","initial-advertise-peer-urls":["https://162.253.55.116:2380"],"listen-peer-urls":["https://162.253.55.116:2380"],"advertise-client-urls":["https://162.253.55.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T00:35:39.778788Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T00:35:40.663719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T00:35:40.663819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T00:35:40.663854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 received MsgPreVoteResp from 9755887b76c83964 at term 1"} {"level":"info","ts":"2026-09-01T00:35:40.663879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became candidate at term 2"} {"level":"info","ts":"2026-09-01T00:35:40.663889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 received MsgVoteResp from 9755887b76c83964 at term 2"} {"level":"info","ts":"2026-09-01T00:35:40.663907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became leader at term 2"} {"level":"info","ts":"2026-09-01T00:35:40.663922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9755887b76c83964 elected leader 9755887b76c83964 at term 2"} {"level":"info","ts":"2026-09-01T00:35:40.665159Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T00:35:40.666141Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T00:35:40.666183Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T00:35:40.666543Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5ee78cd75a03071","local-member-id":"9755887b76c83964","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T00:35:40.666655Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T00:35:40.666733Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T00:35:40.666143Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9755887b76c83964","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.116:2379]}","request-path":"/0/members/9755887b76c83964/attributes","cluster-id":"5ee78cd75a03071","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T00:35:40.666754Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T00:35:40.666852Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T00:35:40.668166Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.116:2379"} {"level":"info","ts":"2026-09-01T00:35:40.669236Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T00:36:19.078882Z","caller":"traceutil/trace.go:171","msg":"trace[710788969] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"150.721506ms","start":"2026-09-01T00:36:18.928137Z","end":"2026-09-01T00:36:19.078858Z","steps":["trace[710788969] 'process raft request' (duration: 150.591131ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:36:21.546195Z","caller":"traceutil/trace.go:171","msg":"trace[657399314] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"102.056052ms","start":"2026-09-01T00:36:21.444118Z","end":"2026-09-01T00:36:21.546174Z","steps":["trace[657399314] 'process raft request' (duration: 101.244543ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:36:21.546348Z","caller":"traceutil/trace.go:171","msg":"trace[549458338] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"101.824104ms","start":"2026-09-01T00:36:21.444513Z","end":"2026-09-01T00:36:21.546337Z","steps":["trace[549458338] 'process raft request' (duration: 100.924972ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:36:28.150607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.389339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-z2n8z\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-01T00:36:28.150744Z","caller":"traceutil/trace.go:171","msg":"trace[1708943620] range","detail":"{range_begin:/registry/pods/kube-system/cilium-z2n8z; range_end:; response_count:1; response_revision:640; }","duration":"346.565854ms","start":"2026-09-01T00:36:27.804158Z","end":"2026-09-01T00:36:28.150724Z","steps":["trace[1708943620] 'range keys from in-memory index tree' (duration: 346.219692ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:36:28.150828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.584101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-01T00:36:28.15083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T00:36:27.804146Z","time spent":"346.670508ms","remote":"127.0.0.1:55504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-z2n8z\" "} {"level":"info","ts":"2026-09-01T00:36:28.150915Z","caller":"traceutil/trace.go:171","msg":"trace[2105990653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:640; }","duration":"432.721077ms","start":"2026-09-01T00:36:27.718175Z","end":"2026-09-01T00:36:28.150896Z","steps":["trace[2105990653] 'range keys from in-memory index tree' (duration: 432.405646ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:36:28.150956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T00:36:27.718153Z","time spent":"432.794098ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-01T00:36:28.201607Z","caller":"traceutil/trace.go:171","msg":"trace[2129989700] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"151.937677ms","start":"2026-09-01T00:36:28.04964Z","end":"2026-09-01T00:36:28.201577Z","steps":["trace[2129989700] 'process raft request' (duration: 145.074073ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:36:28.772324Z","caller":"traceutil/trace.go:171","msg":"trace[1375383221] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"501.773669ms","start":"2026-09-01T00:36:28.27053Z","end":"2026-09-01T00:36:28.772303Z","steps":["trace[1375383221] 'process raft request' (duration: 501.740318ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:36:28.77236Z","caller":"traceutil/trace.go:171","msg":"trace[1594334408] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:664; }","duration":"527.935657ms","start":"2026-09-01T00:36:28.244404Z","end":"2026-09-01T00:36:28.77234Z","steps":["trace[1594334408] 'read index received' (duration: 454.746189ms)","trace[1594334408] 'applied index is now lower than readState.Index' (duration: 73.187118ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T00:36:28.772417Z","caller":"traceutil/trace.go:171","msg":"trace[1542577050] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"603.569645ms","start":"2026-09-01T00:36:28.168831Z","end":"2026-09-01T00:36:28.7724Z","steps":["trace[1542577050] 'process raft request' (duration: 603.383349ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:36:28.772443Z","caller":"traceutil/trace.go:171","msg":"trace[977221111] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"617.280065ms","start":"2026-09-01T00:36:28.1551Z","end":"2026-09-01T00:36:28.77238Z","steps":["trace[977221111] 'process raft request' (duration: 544.073886ms)","trace[977221111] 'compare' (duration: 72.845037ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T00:36:28.773121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.695941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T00:36:28.773157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.991919ms","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-09-01T00:36:28.773191Z","caller":"traceutil/trace.go:171","msg":"trace[413675577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"528.817745ms","start":"2026-09-01T00:36:28.244354Z","end":"2026-09-01T00:36:28.773172Z","steps":["trace[413675577] 'agreement among raft nodes before linearized reading' (duration: 528.088542ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:36:28.773195Z","caller":"traceutil/trace.go:171","msg":"trace[675333690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:644; }","duration":"311.076401ms","start":"2026-09-01T00:36:28.462107Z","end":"2026-09-01T00:36:28.773183Z","steps":["trace[675333690] 'agreement among raft nodes before linearized reading' (duration: 310.372039ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:36:28.773226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T00:36:28.244332Z","time spent":"528.885477ms","remote":"127.0.0.1:55270","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-09-01T00:36:28.77323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T00:36:28.462085Z","time spent":"311.137733ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-01T00:36:28.773538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T00:36:28.270492Z","time spent":"501.899924ms","remote":"127.0.0.1:55550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T00:36:28.773879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T00:36:28.168782Z","time spent":"603.672758ms","remote":"127.0.0.1:55504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T00:36:28.77415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T00:36:28.155076Z","time spent":"617.554203ms","remote":"127.0.0.1:55566","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-09-01T00:36:30.113577Z","caller":"traceutil/trace.go:171","msg":"trace[67403308] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"121.956249ms","start":"2026-09-01T00:36:29.991593Z","end":"2026-09-01T00:36:30.113549Z","steps":["trace[67403308] 'process raft request' (duration: 113.363033ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:36:30.120438Z","caller":"traceutil/trace.go:171","msg":"trace[717765180] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"127.461123ms","start":"2026-09-01T00:36:29.992948Z","end":"2026-09-01T00:36:30.120409Z","steps":["trace[717765180] 'process raft request' (duration: 127.255547ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:36:43.340344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.520628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-01T00:36:43.340441Z","caller":"traceutil/trace.go:171","msg":"trace[2924396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:801; }","duration":"114.665762ms","start":"2026-09-01T00:36:43.225751Z","end":"2026-09-01T00:36:43.340417Z","steps":["trace[2924396] 'range keys from in-memory index tree' (duration: 114.312553ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:37:14.183279Z","caller":"traceutil/trace.go:171","msg":"trace[1255799400] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"101.839087ms","start":"2026-09-01T00:37:14.081394Z","end":"2026-09-01T00:37:14.183233Z","steps":["trace[1255799400] 'process raft request' (duration: 101.224274ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:38:04.523203Z","caller":"traceutil/trace.go:171","msg":"trace[673861774] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"226.6988ms","start":"2026-09-01T00:38:04.296461Z","end":"2026-09-01T00:38:04.52316Z","steps":["trace[673861774] 'process raft request' (duration: 226.542858ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:38:04.864388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.42115ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T00:38:04.864547Z","caller":"traceutil/trace.go:171","msg":"trace[1478659162] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"216.60009ms","start":"2026-09-01T00:38:04.647926Z","end":"2026-09-01T00:38:04.864526Z","steps":["trace[1478659162] 'compare' (duration: 206.224757ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:38:04.895574Z","caller":"traceutil/trace.go:171","msg":"trace[856437045] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"246.93875ms","start":"2026-09-01T00:38:04.648609Z","end":"2026-09-01T00:38:04.895548Z","steps":["trace[856437045] 'process raft request' (duration: 246.769318ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:38:04.89585Z","caller":"traceutil/trace.go:171","msg":"trace[2127571742] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"247.115344ms","start":"2026-09-01T00:38:04.648716Z","end":"2026-09-01T00:38:04.895832Z","steps":["trace[2127571742] 'process raft request' (duration: 246.781009ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:38:04.896344Z","caller":"traceutil/trace.go:171","msg":"trace[1073486017] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"246.618486ms","start":"2026-09-01T00:38:04.649712Z","end":"2026-09-01T00:38:04.89633Z","steps":["trace[1073486017] 'process raft request' (duration: 246.045347ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:38:44.149272Z","caller":"traceutil/trace.go:171","msg":"trace[1048778300] linearizableReadLoop","detail":"{readStateIndex:2238; appliedIndex:2237; }","duration":"109.660572ms","start":"2026-09-01T00:38:44.039583Z","end":"2026-09-01T00:38:44.149243Z","steps":["trace[1048778300] 'read index received' (duration: 80.733018ms)","trace[1048778300] 'applied index is now lower than readState.Index' (duration: 28.925224ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T00:38:44.149323Z","caller":"traceutil/trace.go:171","msg":"trace[1833347864] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"163.979412ms","start":"2026-09-01T00:38:43.985315Z","end":"2026-09-01T00:38:44.149295Z","steps":["trace[1833347864] 'process raft request' (duration: 135.053908ms)","trace[1833347864] 'compare' (duration: 28.67616ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T00:38:44.150021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.420842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-01T00:38:44.150084Z","caller":"traceutil/trace.go:171","msg":"trace[817392310] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2155; }","duration":"110.560143ms","start":"2026-09-01T00:38:44.039508Z","end":"2026-09-01T00:38:44.150068Z","steps":["trace[817392310] 'agreement among raft nodes before linearized reading' (duration: 110.215949ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:39:44.682303Z","caller":"traceutil/trace.go:171","msg":"trace[2133191776] linearizableReadLoop","detail":"{readStateIndex:2683; appliedIndex:2682; }","duration":"230.747938ms","start":"2026-09-01T00:39:44.45154Z","end":"2026-09-01T00:39:44.682288Z","steps":["trace[2133191776] 'read index received' (duration: 230.624856ms)","trace[2133191776] 'applied index is now lower than readState.Index' (duration: 122.432µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T00:39:44.682524Z","caller":"traceutil/trace.go:171","msg":"trace[574141613] transaction","detail":"{read_only:false; response_revision:2586; number_of_response:1; }","duration":"245.225543ms","start":"2026-09-01T00:39:44.437292Z","end":"2026-09-01T00:39:44.682518Z","steps":["trace[574141613] 'process raft request' (duration: 244.910449ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:39:44.682694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.142733ms","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-01T00:39:44.682714Z","caller":"traceutil/trace.go:171","msg":"trace[2081278275] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2586; }","duration":"231.191374ms","start":"2026-09-01T00:39:44.451518Z","end":"2026-09-01T00:39:44.68271Z","steps":["trace[2081278275] 'agreement among raft nodes before linearized reading' (duration: 231.108593ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:39:44.682804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.265189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T00:39:44.682817Z","caller":"traceutil/trace.go:171","msg":"trace[1499728030] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2586; }","duration":"189.281129ms","start":"2026-09-01T00:39:44.493532Z","end":"2026-09-01T00:39:44.682813Z","steps":["trace[1499728030] 'agreement among raft nodes before linearized reading' (duration: 189.239619ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:39:44.682922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.777476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T00:39:44.682938Z","caller":"traceutil/trace.go:171","msg":"trace[1754610962] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:2586; }","duration":"135.795926ms","start":"2026-09-01T00:39:44.547139Z","end":"2026-09-01T00:39:44.682935Z","steps":["trace[1754610962] 'agreement among raft nodes before linearized reading' (duration: 135.768386ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:44:35.676417Z","caller":"traceutil/trace.go:171","msg":"trace[479841089] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"133.613208ms","start":"2026-09-01T00:44:35.542785Z","end":"2026-09-01T00:44:35.676398Z","steps":["trace[479841089] 'process raft request' (duration: 133.484215ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:44:35.676725Z","caller":"traceutil/trace.go:171","msg":"trace[1091525991] linearizableReadLoop","detail":"{readStateIndex:4923; appliedIndex:4923; }","duration":"120.656389ms","start":"2026-09-01T00:44:35.556062Z","end":"2026-09-01T00:44:35.676718Z","steps":["trace[1091525991] 'read index received' (duration: 120.653739ms)","trace[1091525991] 'applied index is now lower than readState.Index' (duration: 2.22µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T00:44:35.676822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.747581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-01T00:44:35.676846Z","caller":"traceutil/trace.go:171","msg":"trace[1475116555] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4743; }","duration":"120.825843ms","start":"2026-09-01T00:44:35.556012Z","end":"2026-09-01T00:44:35.676838Z","steps":["trace[1475116555] 'agreement among raft nodes before linearized reading' (duration: 120.735231ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:44:35.75703Z","caller":"traceutil/trace.go:171","msg":"trace[277517500] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"145.605916ms","start":"2026-09-01T00:44:35.611392Z","end":"2026-09-01T00:44:35.756998Z","steps":["trace[277517500] 'process raft request' (duration: 145.430102ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:44:35.783151Z","caller":"traceutil/trace.go:171","msg":"trace[215424155] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"103.107851ms","start":"2026-09-01T00:44:35.680028Z","end":"2026-09-01T00:44:35.783136Z","steps":["trace[215424155] 'process raft request' (duration: 95.907405ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:44:44.052205Z","caller":"traceutil/trace.go:171","msg":"trace[1641493209] linearizableReadLoop","detail":"{readStateIndex:5068; appliedIndex:5067; }","duration":"194.881972ms","start":"2026-09-01T00:44:43.857281Z","end":"2026-09-01T00:44:44.052163Z","steps":["trace[1641493209] 'read index received' (duration: 194.733709ms)","trace[1641493209] 'applied index is now lower than readState.Index' (duration: 147.063µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T00:44:44.052462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.316613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-01T00:44:44.053027Z","caller":"traceutil/trace.go:171","msg":"trace[323009416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4883; }","duration":"122.932056ms","start":"2026-09-01T00:44:43.93008Z","end":"2026-09-01T00:44:44.053012Z","steps":["trace[323009416] 'agreement among raft nodes before linearized reading' (duration: 122.245061ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:44:44.052993Z","caller":"traceutil/trace.go:171","msg":"trace[1099239077] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"200.92817ms","start":"2026-09-01T00:44:43.851312Z","end":"2026-09-01T00:44:44.05224Z","steps":["trace[1099239077] 'process raft request' (duration: 200.685055ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:44:44.053516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.2207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-01T00:44:44.053612Z","caller":"traceutil/trace.go:171","msg":"trace[887910440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4883; }","duration":"196.325982ms","start":"2026-09-01T00:44:43.857266Z","end":"2026-09-01T00:44:44.053592Z","steps":["trace[887910440] 'agreement among raft nodes before linearized reading' (duration: 195.040256ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:44:44.404607Z","caller":"traceutil/trace.go:171","msg":"trace[904598078] linearizableReadLoop","detail":"{readStateIndex:5075; appliedIndex:5074; }","duration":"122.671467ms","start":"2026-09-01T00:44:44.281913Z","end":"2026-09-01T00:44:44.404584Z","steps":["trace[904598078] 'read index received' (duration: 111.585182ms)","trace[904598078] 'applied index is now lower than readState.Index' (duration: 11.085185ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T00:44:44.404666Z","caller":"traceutil/trace.go:171","msg":"trace[36135504] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"140.561227ms","start":"2026-09-01T00:44:44.264049Z","end":"2026-09-01T00:44:44.40461Z","steps":["trace[36135504] 'process raft request' (duration: 129.455771ms)","trace[36135504] 'compare' (duration: 10.987283ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T00:44:44.404887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.944723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-01T00:44:44.404945Z","caller":"traceutil/trace.go:171","msg":"trace[402361368] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4889; }","duration":"123.042605ms","start":"2026-09-01T00:44:44.281882Z","end":"2026-09-01T00:44:44.404925Z","steps":["trace[402361368] 'agreement among raft nodes before linearized reading' (duration: 122.863102ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:44:50.464907Z","caller":"traceutil/trace.go:171","msg":"trace[1831657113] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"331.056153ms","start":"2026-09-01T00:44:50.133827Z","end":"2026-09-01T00:44:50.464883Z","steps":["trace[1831657113] 'process raft request' (duration: 330.9199ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:44:50.465046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T00:44:50.133801Z","time spent":"331.173726ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T00:44:50.599991Z","caller":"traceutil/trace.go:171","msg":"trace[1162731170] linearizableReadLoop","detail":"{readStateIndex:5225; appliedIndex:5223; }","duration":"357.219062ms","start":"2026-09-01T00:44:50.242748Z","end":"2026-09-01T00:44:50.599967Z","steps":["trace[1162731170] 'read index received' (duration: 221.989649ms)","trace[1162731170] 'applied index is now lower than readState.Index' (duration: 135.228133ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T00:44:50.600138Z","caller":"traceutil/trace.go:171","msg":"trace[13378208] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"466.006452ms","start":"2026-09-01T00:44:50.1341Z","end":"2026-09-01T00:44:50.600106Z","steps":["trace[13378208] 'process raft request' (duration: 427.004565ms)","trace[13378208] 'compare' (duration: 38.491466ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T00:44:50.600257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.495428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T00:44:50.600291Z","caller":"traceutil/trace.go:171","msg":"trace[1568506187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5035; }","duration":"357.57781ms","start":"2026-09-01T00:44:50.242702Z","end":"2026-09-01T00:44:50.600279Z","steps":["trace[1568506187] 'agreement among raft nodes before linearized reading' (duration: 357.413557ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:44:50.600303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T00:44:50.134088Z","time spent":"466.135095ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T00:44:50.600314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T00:44:50.242683Z","time spent":"357.626061ms","remote":"127.0.0.1:55270","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-09-01T00:44:50.600398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.446073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a02738f3-bcff-4142-8428-2b42ca628bc3\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-01T00:44:50.600468Z","caller":"traceutil/trace.go:171","msg":"trace[287410715] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a02738f3-bcff-4142-8428-2b42ca628bc3; range_end:; response_count:1; response_revision:5035; }","duration":"299.574626ms","start":"2026-09-01T00:44:50.300875Z","end":"2026-09-01T00:44:50.60045Z","steps":["trace[287410715] 'agreement among raft nodes before linearized reading' (duration: 299.359011ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:44:50.600597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.416267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a02738f3-bcff-4142-8428-2b42ca628bc3\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-01T00:44:50.600654Z","caller":"traceutil/trace.go:171","msg":"trace[1791573877] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a02738f3-bcff-4142-8428-2b42ca628bc3; range_end:; response_count:1; response_revision:5035; }","duration":"283.506519ms","start":"2026-09-01T00:44:50.317138Z","end":"2026-09-01T00:44:50.600644Z","steps":["trace[1791573877] 'agreement among raft nodes before linearized reading' (duration: 283.372966ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T00:44:50.601266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.431205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-01T00:44:50.601366Z","caller":"traceutil/trace.go:171","msg":"trace[2126206795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5035; }","duration":"143.608379ms","start":"2026-09-01T00:44:50.457741Z","end":"2026-09-01T00:44:50.60135Z","steps":["trace[2126206795] 'agreement among raft nodes before linearized reading' (duration: 142.671839ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:45:40.696172Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2890} {"level":"info","ts":"2026-09-01T00:45:40.793033Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2890,"took":"94.466893ms","hash":2241155985,"current-db-size-bytes":53293056,"current-db-size":"53 MB","current-db-size-in-use-bytes":28446720,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-01T00:45:40.793092Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2241155985,"revision":2890,"compact-revision":-1} {"level":"warn","ts":"2026-09-01T00:45:43.463219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.07563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-01T00:45:43.463298Z","caller":"traceutil/trace.go:171","msg":"trace[1391421727] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5489; }","duration":"137.251294ms","start":"2026-09-01T00:45:43.326029Z","end":"2026-09-01T00:45:43.46328Z","steps":["trace[1391421727] 'range keys from in-memory index tree' (duration: 135.935759ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T00:50:40.703681Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5472} {"level":"info","ts":"2026-09-01T00:50:40.804851Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5472,"took":"99.803119ms","hash":571477663,"current-db-size-bytes":53293056,"current-db-size":"53 MB","current-db-size-in-use-bytes":18767872,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-01T00:50:40.804923Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":571477663,"revision":5472,"compact-revision":2890}