{"level":"warn","ts":"2026-09-19T16:56:48.033206Z","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-19T16:56:48.033318Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.193: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.193:2380","--initial-cluster=instance=https://162.253.55.193:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.193:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.193: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-19T16:56:48.033416Z","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-19T16:56:48.033445Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.193:2380"]} {"level":"info","ts":"2026-09-19T16:56:48.033479Z","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-19T16:56:48.03419Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"]} {"level":"info","ts":"2026-09-19T16:56:48.034291Z","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.193:2380"],"listen-peer-urls":["https://162.253.55.193:2380"],"advertise-client-urls":["https://162.253.55.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.193: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-19T16:56:48.038318Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.723243ms"} {"level":"info","ts":"2026-09-19T16:56:48.045486Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6814e3e3d6b4d713","cluster-id":"e5e99c9118b1492a"} {"level":"info","ts":"2026-09-19T16:56:48.045622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T16:56:48.045702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became follower at term 0"} {"level":"info","ts":"2026-09-19T16:56:48.045715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6814e3e3d6b4d713 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T16:56:48.045744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became follower at term 1"} {"level":"info","ts":"2026-09-19T16:56:48.045807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=(7499869847177975571)"} {"level":"warn","ts":"2026-09-19T16:56:48.052821Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T16:56:48.054287Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T16:56:48.055843Z","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-19T16:56:48.058577Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6814e3e3d6b4d713","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T16:56:48.058732Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6814e3e3d6b4d713","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T16:56:48.058853Z","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-19T16:56:48.058909Z","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-19T16:56:48.058928Z","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-19T16:56:48.062753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=(7499869847177975571)"} {"level":"info","ts":"2026-09-19T16:56:48.063478Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e5e99c9118b1492a","local-member-id":"6814e3e3d6b4d713","added-peer-id":"6814e3e3d6b4d713","added-peer-peer-urls":["https://162.253.55.193:2380"]} {"level":"info","ts":"2026-09-19T16:56:48.066534Z","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-19T16:56:48.066869Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6814e3e3d6b4d713","initial-advertise-peer-urls":["https://162.253.55.193:2380"],"listen-peer-urls":["https://162.253.55.193:2380"],"advertise-client-urls":["https://162.253.55.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T16:56:48.066917Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T16:56:48.066646Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.193:2380"} {"level":"info","ts":"2026-09-19T16:56:48.067258Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.193:2380"} {"level":"info","ts":"2026-09-19T16:56:48.946722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T16:56:48.946804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T16:56:48.946855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 received MsgPreVoteResp from 6814e3e3d6b4d713 at term 1"} {"level":"info","ts":"2026-09-19T16:56:48.946882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became candidate at term 2"} {"level":"info","ts":"2026-09-19T16:56:48.946894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 received MsgVoteResp from 6814e3e3d6b4d713 at term 2"} {"level":"info","ts":"2026-09-19T16:56:48.946912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became leader at term 2"} {"level":"info","ts":"2026-09-19T16:56:48.946935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6814e3e3d6b4d713 elected leader 6814e3e3d6b4d713 at term 2"} {"level":"info","ts":"2026-09-19T16:56:48.950046Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T16:56:48.95117Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6814e3e3d6b4d713","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.193:2379]}","request-path":"/0/members/6814e3e3d6b4d713/attributes","cluster-id":"e5e99c9118b1492a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T16:56:48.951182Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T16:56:48.951233Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T16:56:48.951507Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T16:56:48.951539Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T16:56:48.951915Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e5e99c9118b1492a","local-member-id":"6814e3e3d6b4d713","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T16:56:48.952094Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T16:56:48.952143Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T16:56:48.955379Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T16:56:48.955393Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.193:2379"} {"level":"info","ts":"2026-09-19T16:56:57.622745Z","caller":"traceutil/trace.go:171","msg":"trace[1968216514] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"317.766415ms","start":"2026-09-19T16:56:57.304946Z","end":"2026-09-19T16:56:57.622713Z","steps":["trace[1968216514] 'process raft request' (duration: 317.565959ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:56:57.623632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T16:56:57.30491Z","time spent":"317.982801ms","remote":"127.0.0.1:35666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T16:56:57.665306Z","caller":"traceutil/trace.go:171","msg":"trace[1557315048] linearizableReadLoop","detail":"{readStateIndex:347; appliedIndex:345; }","duration":"315.43022ms","start":"2026-09-19T16:56:57.349846Z","end":"2026-09-19T16:56:57.665276Z","steps":["trace[1557315048] 'read index received' (duration: 272.622326ms)","trace[1557315048] 'applied index is now lower than readState.Index' (duration: 42.806703ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T16:56:57.665522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.652715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T16:56:57.665577Z","caller":"traceutil/trace.go:171","msg":"trace[711537484] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:335; }","duration":"315.785059ms","start":"2026-09-19T16:56:57.349778Z","end":"2026-09-19T16:56:57.665563Z","steps":["trace[711537484] 'agreement among raft nodes before linearized reading' (duration: 315.614364ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:56:57.665617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T16:56:57.349753Z","time spent":"315.854881ms","remote":"127.0.0.1:35430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-19T16:56:57.665875Z","caller":"traceutil/trace.go:171","msg":"trace[2117059730] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"320.592474ms","start":"2026-09-19T16:56:57.345242Z","end":"2026-09-19T16:56:57.665834Z","steps":["trace[2117059730] 'process raft request' (duration: 319.826823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:56:57.666039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T16:56:57.345124Z","time spent":"320.82995ms","remote":"127.0.0.1:35678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":197,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T16:56:57.781719Z","caller":"traceutil/trace.go:171","msg":"trace[1767520219] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"104.139859ms","start":"2026-09-19T16:56:57.677546Z","end":"2026-09-19T16:56:57.781686Z","steps":["trace[1767520219] 'process raft request' (duration: 101.0001ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:56:57.783775Z","caller":"traceutil/trace.go:171","msg":"trace[1295755286] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"102.109591ms","start":"2026-09-19T16:56:57.681648Z","end":"2026-09-19T16:56:57.783758Z","steps":["trace[1295755286] 'process raft request' (duration: 101.982817ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:57:30.993556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.119878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T16:57:30.994051Z","caller":"traceutil/trace.go:171","msg":"trace[191586682] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"388.599908ms","start":"2026-09-19T16:57:30.605266Z","end":"2026-09-19T16:57:30.993865Z","steps":["trace[191586682] 'process raft request' (duration: 215.847736ms)","trace[191586682] 'compare' (duration: 171.74629ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T16:57:30.994148Z","caller":"traceutil/trace.go:171","msg":"trace[1253451978] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:597; }","duration":"373.32015ms","start":"2026-09-19T16:57:30.620784Z","end":"2026-09-19T16:57:30.994104Z","steps":["trace[1253451978] 'read index received' (duration: 42.908279ms)","trace[1253451978] 'applied index is now lower than readState.Index' (duration: 330.406731ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T16:57:30.994367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.575245ms","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-19T16:57:30.994419Z","caller":"traceutil/trace.go:171","msg":"trace[221503499] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:576; }","duration":"373.660607ms","start":"2026-09-19T16:57:30.620745Z","end":"2026-09-19T16:57:30.994406Z","steps":["trace[221503499] 'agreement among raft nodes before linearized reading' (duration: 373.522194ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:57:30.994436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.521448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-19T16:57:30.994452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.73779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-09-19T16:57:30.994467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T16:57:30.620725Z","time spent":"373.732489ms","remote":"127.0.0.1:35740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-19T16:57:30.994495Z","caller":"traceutil/trace.go:171","msg":"trace[1809257062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:576; }","duration":"102.633361ms","start":"2026-09-19T16:57:30.891835Z","end":"2026-09-19T16:57:30.994469Z","steps":["trace[1809257062] 'agreement among raft nodes before linearized reading' (duration: 102.510868ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:57:30.994512Z","caller":"traceutil/trace.go:171","msg":"trace[178842876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"152.849722ms","start":"2026-09-19T16:57:30.841649Z","end":"2026-09-19T16:57:30.994499Z","steps":["trace[178842876] 'agreement among raft nodes before linearized reading' (duration: 152.710718ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:57:30.994422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.876151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-19T16:57:30.994643Z","caller":"traceutil/trace.go:171","msg":"trace[1345378964] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:576; }","duration":"336.121117ms","start":"2026-09-19T16:57:30.658513Z","end":"2026-09-19T16:57:30.994634Z","steps":["trace[1345378964] 'agreement among raft nodes before linearized reading' (duration: 335.80962ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:57:30.994124Z","caller":"traceutil/trace.go:171","msg":"trace[1777521423] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"282.205794ms","start":"2026-09-19T16:57:30.71189Z","end":"2026-09-19T16:57:30.994095Z","steps":["trace[1777521423] 'process raft request' (duration: 282.03053ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:57:30.99467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T16:57:30.658496Z","time spent":"336.164408ms","remote":"127.0.0.1:35574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-19T16:57:30.994596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T16:57:30.605252Z","time spent":"388.950646ms","remote":"127.0.0.1:35508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T16:57:30.994077Z","caller":"traceutil/trace.go:171","msg":"trace[625430414] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"361.960959ms","start":"2026-09-19T16:57:30.632048Z","end":"2026-09-19T16:57:30.994009Z","steps":["trace[625430414] 'process raft request' (duration: 361.671532ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:57:30.994878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T16:57:30.632014Z","time spent":"362.792477ms","remote":"127.0.0.1:35508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T16:57:31.743132Z","caller":"traceutil/trace.go:171","msg":"trace[603742030] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"128.506146ms","start":"2026-09-19T16:57:31.614583Z","end":"2026-09-19T16:57:31.74309Z","steps":["trace[603742030] 'process raft request' (duration: 114.104999ms)","trace[603742030] 'compare' (duration: 14.153182ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T16:57:38.191649Z","caller":"traceutil/trace.go:171","msg":"trace[2041658292] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"167.91196ms","start":"2026-09-19T16:57:38.023699Z","end":"2026-09-19T16:57:38.191611Z","steps":["trace[2041658292] 'process raft request' (duration: 167.619134ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:57:38.19172Z","caller":"traceutil/trace.go:171","msg":"trace[1413224366] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"166.784636ms","start":"2026-09-19T16:57:38.024887Z","end":"2026-09-19T16:57:38.191672Z","steps":["trace[1413224366] 'process raft request' (duration: 166.608212ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:57:38.191678Z","caller":"traceutil/trace.go:171","msg":"trace[731625561] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"165.54336ms","start":"2026-09-19T16:57:38.026099Z","end":"2026-09-19T16:57:38.191642Z","steps":["trace[731625561] 'process raft request' (duration: 165.473639ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:57:38.651722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.501097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bfm42\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-19T16:57:38.651823Z","caller":"traceutil/trace.go:171","msg":"trace[176005787] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bfm42; range_end:; response_count:1; response_revision:709; }","duration":"191.659681ms","start":"2026-09-19T16:57:38.460141Z","end":"2026-09-19T16:57:38.651801Z","steps":["trace[176005787] 'range keys from in-memory index tree' (duration: 191.297313ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:57:55.478221Z","caller":"traceutil/trace.go:171","msg":"trace[134196066] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:859; }","duration":"195.443545ms","start":"2026-09-19T16:57:55.282748Z","end":"2026-09-19T16:57:55.478191Z","steps":["trace[134196066] 'read index received' (duration: 195.336483ms)","trace[134196066] 'applied index is now lower than readState.Index' (duration: 106.312µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T16:57:55.478274Z","caller":"traceutil/trace.go:171","msg":"trace[1694513477] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"220.403666ms","start":"2026-09-19T16:57:55.257842Z","end":"2026-09-19T16:57:55.478245Z","steps":["trace[1694513477] 'process raft request' (duration: 220.218542ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:57:55.478524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.709731ms","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-19T16:57:55.478565Z","caller":"traceutil/trace.go:171","msg":"trace[969180799] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:828; }","duration":"195.812193ms","start":"2026-09-19T16:57:55.282741Z","end":"2026-09-19T16:57:55.478554Z","steps":["trace[969180799] 'agreement among raft nodes before linearized reading' (duration: 195.561138ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:59:23.852078Z","caller":"traceutil/trace.go:171","msg":"trace[2079432891] linearizableReadLoop","detail":"{readStateIndex:2010; appliedIndex:2009; }","duration":"208.460548ms","start":"2026-09-19T16:59:23.643585Z","end":"2026-09-19T16:59:23.852046Z","steps":["trace[2079432891] 'read index received' (duration: 208.255735ms)","trace[2079432891] 'applied index is now lower than readState.Index' (duration: 203.433µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T16:59:23.852149Z","caller":"traceutil/trace.go:171","msg":"trace[1464137480] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"218.499847ms","start":"2026-09-19T16:59:23.633606Z","end":"2026-09-19T16:59:23.852106Z","steps":["trace[1464137480] 'process raft request' (duration: 218.250663ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:59:23.852352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.748343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-19T16:59:23.852433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.620421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-19T16:59:23.852459Z","caller":"traceutil/trace.go:171","msg":"trace[410760537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1932; }","duration":"208.924185ms","start":"2026-09-19T16:59:23.643515Z","end":"2026-09-19T16:59:23.852439Z","steps":["trace[410760537] 'agreement among raft nodes before linearized reading' (duration: 208.675031ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:59:23.852463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.745191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-19T16:59:23.852528Z","caller":"traceutil/trace.go:171","msg":"trace[473789050] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1932; }","duration":"208.751102ms","start":"2026-09-19T16:59:23.643719Z","end":"2026-09-19T16:59:23.85247Z","steps":["trace[473789050] 'agreement among raft nodes before linearized reading' (duration: 208.519279ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:59:23.852635Z","caller":"traceutil/trace.go:171","msg":"trace[1934371252] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1932; }","duration":"139.927824ms","start":"2026-09-19T16:59:23.712685Z","end":"2026-09-19T16:59:23.852613Z","steps":["trace[1934371252] 'agreement among raft nodes before linearized reading' (duration: 139.625749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T16:59:23.852928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.139928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-19T16:59:23.852995Z","caller":"traceutil/trace.go:171","msg":"trace[1603339191] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1932; }","duration":"184.26451ms","start":"2026-09-19T16:59:23.668718Z","end":"2026-09-19T16:59:23.852982Z","steps":["trace[1603339191] 'agreement among raft nodes before linearized reading' (duration: 183.918545ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:59:24.045502Z","caller":"traceutil/trace.go:171","msg":"trace[1121253460] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"184.418992ms","start":"2026-09-19T16:59:23.861055Z","end":"2026-09-19T16:59:24.045474Z","steps":["trace[1121253460] 'process raft request' (duration: 184.234309ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:59:24.091708Z","caller":"traceutil/trace.go:171","msg":"trace[762295107] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"230.333861ms","start":"2026-09-19T16:59:23.861342Z","end":"2026-09-19T16:59:24.091676Z","steps":["trace[762295107] 'process raft request' (duration: 230.124818ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:59:24.09208Z","caller":"traceutil/trace.go:171","msg":"trace[1875680203] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"230.698847ms","start":"2026-09-19T16:59:23.861362Z","end":"2026-09-19T16:59:24.092061Z","steps":["trace[1875680203] 'process raft request' (duration: 230.25621ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T16:59:24.396869Z","caller":"traceutil/trace.go:171","msg":"trace[112146798] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"295.895468ms","start":"2026-09-19T16:59:24.100892Z","end":"2026-09-19T16:59:24.396788Z","steps":["trace[112146798] 'process raft request' (duration: 285.27924ms)","trace[112146798] 'compare' (duration: 10.259833ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T17:00:03.684385Z","caller":"traceutil/trace.go:171","msg":"trace[1411264044] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"198.923479ms","start":"2026-09-19T17:00:03.485429Z","end":"2026-09-19T17:00:03.684353Z","steps":["trace[1411264044] 'process raft request' (duration: 186.20056ms)","trace[1411264044] 'compare' (duration: 12.568687ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T17:00:56.13073Z","caller":"traceutil/trace.go:171","msg":"trace[1239198462] transaction","detail":"{read_only:false; response_revision:2587; number_of_response:1; }","duration":"157.388445ms","start":"2026-09-19T17:00:55.973318Z","end":"2026-09-19T17:00:56.130706Z","steps":["trace[1239198462] 'process raft request' (duration: 157.25412ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T17:01:32.608105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.597122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T17:01:32.608251Z","caller":"traceutil/trace.go:171","msg":"trace[317898474] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:2784; }","duration":"157.835409ms","start":"2026-09-19T17:01:32.450391Z","end":"2026-09-19T17:01:32.608227Z","steps":["trace[317898474] 'count revisions from in-memory index tree' (duration: 157.517709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T17:01:32.608374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.502967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T17:01:32.60882Z","caller":"traceutil/trace.go:171","msg":"trace[899550604] transaction","detail":"{read_only:false; response_revision:2785; number_of_response:1; }","duration":"149.49874ms","start":"2026-09-19T17:01:32.459274Z","end":"2026-09-19T17:01:32.608773Z","steps":["trace[899550604] 'compare' (duration: 139.231348ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T17:06:22.45546Z","caller":"traceutil/trace.go:171","msg":"trace[1780194605] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"106.805174ms","start":"2026-09-19T17:06:22.34859Z","end":"2026-09-19T17:06:22.455395Z","steps":["trace[1780194605] 'process raft request' (duration: 13.412329ms)","trace[1780194605] 'compare' (duration: 93.198821ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T17:06:22.584634Z","caller":"traceutil/trace.go:171","msg":"trace[79800546] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"113.536849ms","start":"2026-09-19T17:06:22.471067Z","end":"2026-09-19T17:06:22.584604Z","steps":["trace[79800546] 'process raft request' (duration: 113.358816ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T17:06:22.585113Z","caller":"traceutil/trace.go:171","msg":"trace[904338485] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"122.849022ms","start":"2026-09-19T17:06:22.462232Z","end":"2026-09-19T17:06:22.585081Z","steps":["trace[904338485] 'process raft request' (duration: 109.497814ms)","trace[904338485] 'compare' (duration: 12.216967ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T17:06:22.585301Z","caller":"traceutil/trace.go:171","msg":"trace[55879092] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"122.840612ms","start":"2026-09-19T17:06:22.46245Z","end":"2026-09-19T17:06:22.585291Z","steps":["trace[55879092] 'process raft request' (duration: 121.808053ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T17:06:22.585444Z","caller":"traceutil/trace.go:171","msg":"trace[1673030605] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"122.961634ms","start":"2026-09-19T17:06:22.462473Z","end":"2026-09-19T17:06:22.585434Z","steps":["trace[1673030605] 'process raft request' (duration: 121.853744ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T17:06:22.585542Z","caller":"traceutil/trace.go:171","msg":"trace[105940818] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"122.972234ms","start":"2026-09-19T17:06:22.46256Z","end":"2026-09-19T17:06:22.585532Z","steps":["trace[105940818] 'process raft request' (duration: 121.807053ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T17:06:22.723085Z","caller":"traceutil/trace.go:171","msg":"trace[223549008] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"122.693889ms","start":"2026-09-19T17:06:22.600363Z","end":"2026-09-19T17:06:22.723057Z","steps":["trace[223549008] 'process raft request' (duration: 122.637138ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T17:06:22.723486Z","caller":"traceutil/trace.go:171","msg":"trace[1557800695] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"125.102394ms","start":"2026-09-19T17:06:22.598365Z","end":"2026-09-19T17:06:22.723468Z","steps":["trace[1557800695] 'process raft request' (duration: 101.945994ms)","trace[1557800695] 'compare' (duration: 22.552559ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T17:06:27.634221Z","caller":"traceutil/trace.go:171","msg":"trace[1358343374] transaction","detail":"{read_only:false; response_revision:5156; number_of_response:1; }","duration":"228.531681ms","start":"2026-09-19T17:06:27.405659Z","end":"2026-09-19T17:06:27.634191Z","steps":["trace[1358343374] 'process raft request' (duration: 228.376848ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T17:06:27.634448Z","caller":"traceutil/trace.go:171","msg":"trace[1926560808] linearizableReadLoop","detail":"{readStateIndex:5351; appliedIndex:5351; }","duration":"138.330381ms","start":"2026-09-19T17:06:27.496066Z","end":"2026-09-19T17:06:27.634397Z","steps":["trace[1926560808] 'read index received' (duration: 138.314491ms)","trace[1926560808] 'applied index is now lower than readState.Index' (duration: 12.14µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T17:06:27.634585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.509685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-abf188e6-4bdf-40e0-8437-17ddbbdeb01d\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-09-19T17:06:27.634655Z","caller":"traceutil/trace.go:171","msg":"trace[1288734985] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-abf188e6-4bdf-40e0-8437-17ddbbdeb01d; range_end:; response_count:1; response_revision:5156; }","duration":"138.645927ms","start":"2026-09-19T17:06:27.495996Z","end":"2026-09-19T17:06:27.634642Z","steps":["trace[1288734985] 'agreement among raft nodes before linearized reading' (duration: 138.482824ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T17:06:27.703364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.973586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T17:06:27.703466Z","caller":"traceutil/trace.go:171","msg":"trace[1182455070] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5157; }","duration":"184.1209ms","start":"2026-09-19T17:06:27.51932Z","end":"2026-09-19T17:06:27.703441Z","steps":["trace[1182455070] 'agreement among raft nodes before linearized reading' (duration: 183.907596ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T17:06:27.703627Z","caller":"traceutil/trace.go:171","msg":"trace[1899788570] transaction","detail":"{read_only:false; response_revision:5157; number_of_response:1; }","duration":"176.079421ms","start":"2026-09-19T17:06:27.527472Z","end":"2026-09-19T17:06:27.703552Z","steps":["trace[1899788570] 'process raft request' (duration: 175.533501ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T17:06:48.983258Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2874} {"level":"info","ts":"2026-09-19T17:06:49.060665Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2874,"took":"75.891067ms","hash":3602194544,"current-db-size-bytes":51552256,"current-db-size":"52 MB","current-db-size-in-use-bytes":27607040,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-19T17:06:49.06076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3602194544,"revision":2874,"compact-revision":-1} {"level":"info","ts":"2026-09-19T17:11:48.993232Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5361} {"level":"info","ts":"2026-09-19T17:11:49.124042Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5361,"took":"128.422355ms","hash":2928671293,"current-db-size-bytes":51552256,"current-db-size":"52 MB","current-db-size-in-use-bytes":18874368,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-19T17:11:49.124144Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2928671293,"revision":5361,"compact-revision":2874}