{"level":"warn","ts":"2026-09-30T02:16:43.738325Z","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-30T02:16:43.73844Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.164: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.164:2380","--initial-cluster=instance=https://162.253.55.164:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.164:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.164: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-30T02:16:43.738615Z","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-30T02:16:43.738643Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.164:2380"]} {"level":"info","ts":"2026-09-30T02:16:43.738707Z","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-30T02:16:43.739571Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.164:2379"]} {"level":"info","ts":"2026-09-30T02:16:43.739737Z","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.164:2380"],"listen-peer-urls":["https://162.253.55.164:2380"],"advertise-client-urls":["https://162.253.55.164:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.164:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.164: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-30T02:16:43.744358Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.276561ms"} {"level":"info","ts":"2026-09-30T02:16:43.751761Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"777352cb93f4c05d","cluster-id":"ebb6470dab83b2e8"} {"level":"info","ts":"2026-09-30T02:16:43.751877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d switched to configuration voters=()"} {"level":"info","ts":"2026-09-30T02:16:43.751913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became follower at term 0"} {"level":"info","ts":"2026-09-30T02:16:43.75193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 777352cb93f4c05d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-30T02:16:43.751949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became follower at term 1"} {"level":"info","ts":"2026-09-30T02:16:43.752005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d switched to configuration voters=(8607314347149279325)"} {"level":"warn","ts":"2026-09-30T02:16:43.759045Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-30T02:16:43.760553Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-30T02:16:43.762114Z","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-30T02:16:43.764515Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"777352cb93f4c05d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-30T02:16:43.764798Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"777352cb93f4c05d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-30T02:16:43.764709Z","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-30T02:16:43.769528Z","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-30T02:16:43.769556Z","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-30T02:16:43.771203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d switched to configuration voters=(8607314347149279325)"} {"level":"info","ts":"2026-09-30T02:16:43.771395Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ebb6470dab83b2e8","local-member-id":"777352cb93f4c05d","added-peer-id":"777352cb93f4c05d","added-peer-peer-urls":["https://162.253.55.164:2380"]} {"level":"info","ts":"2026-09-30T02:16:43.7739Z","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-30T02:16:43.774278Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"777352cb93f4c05d","initial-advertise-peer-urls":["https://162.253.55.164:2380"],"listen-peer-urls":["https://162.253.55.164:2380"],"advertise-client-urls":["https://162.253.55.164:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.164:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-30T02:16:43.774346Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-30T02:16:43.774935Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.164:2380"} {"level":"info","ts":"2026-09-30T02:16:43.774981Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.164:2380"} {"level":"info","ts":"2026-09-30T02:16:44.253103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d is starting a new election at term 1"} {"level":"info","ts":"2026-09-30T02:16:44.25318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-30T02:16:44.253224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d received MsgPreVoteResp from 777352cb93f4c05d at term 1"} {"level":"info","ts":"2026-09-30T02:16:44.253299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became candidate at term 2"} {"level":"info","ts":"2026-09-30T02:16:44.253382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d received MsgVoteResp from 777352cb93f4c05d at term 2"} {"level":"info","ts":"2026-09-30T02:16:44.25341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became leader at term 2"} {"level":"info","ts":"2026-09-30T02:16:44.253424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 777352cb93f4c05d elected leader 777352cb93f4c05d at term 2"} {"level":"info","ts":"2026-09-30T02:16:44.25469Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"777352cb93f4c05d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.164:2379]}","request-path":"/0/members/777352cb93f4c05d/attributes","cluster-id":"ebb6470dab83b2e8","publish-timeout":"7s"} {"level":"info","ts":"2026-09-30T02:16:44.254817Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-30T02:16:44.255024Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T02:16:44.255384Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-30T02:16:44.256487Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ebb6470dab83b2e8","local-member-id":"777352cb93f4c05d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T02:16:44.256631Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T02:16:44.256666Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T02:16:44.259854Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.164:2379"} {"level":"info","ts":"2026-09-30T02:16:44.260149Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-30T02:16:44.260243Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-30T02:16:44.262451Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-30T02:17:31.887949Z","caller":"traceutil/trace.go:171","msg":"trace[1861960496] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"159.911665ms","start":"2026-09-30T02:17:31.728007Z","end":"2026-09-30T02:17:31.887918Z","steps":["trace[1861960496] 'process raft request' (duration: 159.755523ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:17:32.569501Z","caller":"traceutil/trace.go:171","msg":"trace[1218824824] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"394.063348ms","start":"2026-09-30T02:17:32.1754Z","end":"2026-09-30T02:17:32.569463Z","steps":["trace[1218824824] 'process raft request' (duration: 389.165682ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:17:32.571084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:17:32.175371Z","time spent":"394.200981ms","remote":"127.0.0.1:54464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-30T02:17:32.645717Z","caller":"traceutil/trace.go:171","msg":"trace[317370273] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:631; }","duration":"191.060383ms","start":"2026-09-30T02:17:32.454591Z","end":"2026-09-30T02:17:32.645652Z","steps":["trace[317370273] 'read index received' (duration: 110.004773ms)","trace[317370273] 'applied index is now lower than readState.Index' (duration: 81.0545ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T02:17:32.645906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.302547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-30T02:17:32.645969Z","caller":"traceutil/trace.go:171","msg":"trace[1945883015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"191.416648ms","start":"2026-09-30T02:17:32.454543Z","end":"2026-09-30T02:17:32.64596Z","steps":["trace[1945883015] 'agreement among raft nodes before linearized reading' (duration: 191.261915ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:17:32.64586Z","caller":"traceutil/trace.go:171","msg":"trace[978216805] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"338.768977ms","start":"2026-09-30T02:17:32.306977Z","end":"2026-09-30T02:17:32.645746Z","steps":["trace[978216805] 'process raft request' (duration: 338.021698ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:17:32.6462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:17:32.306946Z","time spent":"339.117093ms","remote":"127.0.0.1:54376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-30T02:17:34.259478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.504514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-30T02:17:34.25974Z","caller":"traceutil/trace.go:171","msg":"trace[1355698678] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"272.090274ms","start":"2026-09-30T02:17:33.987595Z","end":"2026-09-30T02:17:34.259686Z","steps":["trace[1355698678] 'process raft request' (duration: 89.051312ms)","trace[1355698678] 'compare' (duration: 182.323092ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:17:34.295006Z","caller":"traceutil/trace.go:171","msg":"trace[1796348904] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"200.851252ms","start":"2026-09-30T02:17:34.094129Z","end":"2026-09-30T02:17:34.29498Z","steps":["trace[1796348904] 'read index received' (duration: 200.653259ms)","trace[1796348904] 'applied index is now lower than readState.Index' (duration: 196.733µs)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:17:34.295254Z","caller":"traceutil/trace.go:171","msg":"trace[605089931] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"305.759798ms","start":"2026-09-30T02:17:33.989469Z","end":"2026-09-30T02:17:34.295229Z","steps":["trace[605089931] 'process raft request' (duration: 305.437394ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:17:34.295275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.091415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-pdrhh\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-09-30T02:17:34.295224Z","caller":"traceutil/trace.go:171","msg":"trace[1564238811] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"305.772789ms","start":"2026-09-30T02:17:33.989421Z","end":"2026-09-30T02:17:34.295193Z","steps":["trace[1564238811] 'process raft request' (duration: 305.327973ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:17:34.295372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:17:33.989449Z","time spent":"305.856719ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-30T02:17:34.295366Z","caller":"traceutil/trace.go:171","msg":"trace[863873775] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-pdrhh; range_end:; response_count:1; response_revision:628; }","duration":"201.234588ms","start":"2026-09-30T02:17:34.094079Z","end":"2026-09-30T02:17:34.295313Z","steps":["trace[863873775] 'agreement among raft nodes before linearized reading' (duration: 201.003974ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:17:34.295567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:17:33.989406Z","time spent":"306.083183ms","remote":"127.0.0.1:54334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-30T02:17:34.344339Z","caller":"traceutil/trace.go:171","msg":"trace[1766988474] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"162.713587ms","start":"2026-09-30T02:17:34.181607Z","end":"2026-09-30T02:17:34.34432Z","steps":["trace[1766988474] 'process raft request' (duration: 162.589846ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:17:34.344373Z","caller":"traceutil/trace.go:171","msg":"trace[1251584333] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"246.836592ms","start":"2026-09-30T02:17:34.097516Z","end":"2026-09-30T02:17:34.344353Z","steps":["trace[1251584333] 'process raft request' (duration: 246.587808ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:17:48.685231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.240911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-30T02:17:48.68536Z","caller":"traceutil/trace.go:171","msg":"trace[1593801245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:771; }","duration":"114.479515ms","start":"2026-09-30T02:17:48.570851Z","end":"2026-09-30T02:17:48.685331Z","steps":["trace[1593801245] 'range keys from in-memory index tree' (duration: 114.153231ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:18:56.145247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.210077ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-30T02:18:56.145371Z","caller":"traceutil/trace.go:171","msg":"trace[715020884] transaction","detail":"{read_only:false; response_revision:1678; number_of_response:1; }","duration":"254.476565ms","start":"2026-09-30T02:18:55.89087Z","end":"2026-09-30T02:18:56.145347Z","steps":["trace[715020884] 'process raft request' (duration: 98.061546ms)","trace[715020884] 'compare' (duration: 155.906973ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:18:56.145656Z","caller":"traceutil/trace.go:171","msg":"trace[1279520745] linearizableReadLoop","detail":"{readStateIndex:1747; appliedIndex:1745; }","duration":"218.454506ms","start":"2026-09-30T02:18:55.927185Z","end":"2026-09-30T02:18:56.145639Z","steps":["trace[1279520745] 'read index received' (duration: 62.004817ms)","trace[1279520745] 'applied index is now lower than readState.Index' (duration: 156.448909ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:18:56.145735Z","caller":"traceutil/trace.go:171","msg":"trace[748979261] transaction","detail":"{read_only:false; response_revision:1679; number_of_response:1; }","duration":"253.701766ms","start":"2026-09-30T02:18:55.892028Z","end":"2026-09-30T02:18:56.145729Z","steps":["trace[748979261] 'process raft request' (duration: 253.535135ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:18:56.14607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.865621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-09-30T02:18:56.146126Z","caller":"traceutil/trace.go:171","msg":"trace[1688044983] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1679; }","duration":"218.965801ms","start":"2026-09-30T02:18:55.927146Z","end":"2026-09-30T02:18:56.146111Z","steps":["trace[1688044983] 'agreement among raft nodes before linearized reading' (duration: 218.758709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:18:56.154063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.829612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-09-30T02:18:56.15411Z","caller":"traceutil/trace.go:171","msg":"trace[520336425] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1680; }","duration":"102.904503ms","start":"2026-09-30T02:18:56.051194Z","end":"2026-09-30T02:18:56.154098Z","steps":["trace[520336425] 'agreement among raft nodes before linearized reading' (duration: 102.779231ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:09.96811Z","caller":"traceutil/trace.go:171","msg":"trace[1869312200] linearizableReadLoop","detail":"{readStateIndex:1937; appliedIndex:1936; }","duration":"175.649036ms","start":"2026-09-30T02:19:09.792429Z","end":"2026-09-30T02:19:09.968078Z","steps":["trace[1869312200] 'read index received' (duration: 165.73585ms)","trace[1869312200] 'applied index is now lower than readState.Index' (duration: 9.911886ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:19:09.968157Z","caller":"traceutil/trace.go:171","msg":"trace[316382438] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"368.213553ms","start":"2026-09-30T02:19:09.599901Z","end":"2026-09-30T02:19:09.968115Z","steps":["trace[316382438] 'process raft request' (duration: 358.238226ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:19:09.968402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:19:09.59988Z","time spent":"368.420725ms","remote":"127.0.0.1:54464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10967,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-30T02:19:09.968698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.230604ms","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-30T02:19:09.96875Z","caller":"traceutil/trace.go:171","msg":"trace[476427336] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1862; }","duration":"176.356315ms","start":"2026-09-30T02:19:09.792379Z","end":"2026-09-30T02:19:09.968735Z","steps":["trace[476427336] 'agreement among raft nodes before linearized reading' (duration: 175.801909ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:09.975209Z","caller":"traceutil/trace.go:171","msg":"trace[1148306687] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"157.277841ms","start":"2026-09-30T02:19:09.817907Z","end":"2026-09-30T02:19:09.975185Z","steps":["trace[1148306687] 'process raft request' (duration: 157.078727ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:10.117329Z","caller":"traceutil/trace.go:171","msg":"trace[244308341] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"133.387708ms","start":"2026-09-30T02:19:09.983917Z","end":"2026-09-30T02:19:10.117304Z","steps":["trace[244308341] 'process raft request' (duration: 133.175796ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:26.530796Z","caller":"traceutil/trace.go:171","msg":"trace[1945307683] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"111.843113ms","start":"2026-09-30T02:19:26.418931Z","end":"2026-09-30T02:19:26.530775Z","steps":["trace[1945307683] 'process raft request' (duration: 111.688362ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:26.533608Z","caller":"traceutil/trace.go:171","msg":"trace[392763563] transaction","detail":"{read_only:false; response_revision:2005; number_of_response:1; }","duration":"112.183717ms","start":"2026-09-30T02:19:26.421388Z","end":"2026-09-30T02:19:26.533572Z","steps":["trace[392763563] 'process raft request' (duration: 111.981395ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:48.968038Z","caller":"traceutil/trace.go:171","msg":"trace[1526638896] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"100.917624ms","start":"2026-09-30T02:19:48.867098Z","end":"2026-09-30T02:19:48.968016Z","steps":["trace[1526638896] 'process raft request' (duration: 100.775392ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:49.521812Z","caller":"traceutil/trace.go:171","msg":"trace[1239875106] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"102.984277ms","start":"2026-09-30T02:19:49.418793Z","end":"2026-09-30T02:19:49.521777Z","steps":["trace[1239875106] 'process raft request' (duration: 102.725734ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:49.937948Z","caller":"traceutil/trace.go:171","msg":"trace[1369594594] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"141.308171ms","start":"2026-09-30T02:19:49.796611Z","end":"2026-09-30T02:19:49.937919Z","steps":["trace[1369594594] 'process raft request' (duration: 141.168219ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:21:43.250761Z","caller":"traceutil/trace.go:171","msg":"trace[790800932] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"113.394882ms","start":"2026-09-30T02:21:43.137328Z","end":"2026-09-30T02:21:43.250723Z","steps":["trace[790800932] 'process raft request' (duration: 113.148693ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:21:43.434732Z","caller":"traceutil/trace.go:171","msg":"trace[1412232421] linearizableReadLoop","detail":"{readStateIndex:2957; appliedIndex:2956; }","duration":"105.489605ms","start":"2026-09-30T02:21:43.329218Z","end":"2026-09-30T02:21:43.434708Z","steps":["trace[1412232421] 'read index received' (duration: 100.223682ms)","trace[1412232421] 'applied index is now lower than readState.Index' (duration: 5.264693ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T02:21:43.435072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.831098ms","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-30T02:21:43.435218Z","caller":"traceutil/trace.go:171","msg":"trace[615968555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2848; }","duration":"105.982984ms","start":"2026-09-30T02:21:43.329176Z","end":"2026-09-30T02:21:43.435159Z","steps":["trace[615968555] 'agreement among raft nodes before linearized reading' (duration: 105.631491ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:26:14.9886Z","caller":"traceutil/trace.go:171","msg":"trace[897112715] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"100.553944ms","start":"2026-09-30T02:26:14.888026Z","end":"2026-09-30T02:26:14.98858Z","steps":["trace[897112715] 'process raft request' (duration: 100.426241ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:26:21.479397Z","caller":"traceutil/trace.go:171","msg":"trace[631849994] transaction","detail":"{read_only:false; response_revision:5021; number_of_response:1; }","duration":"126.530675ms","start":"2026-09-30T02:26:21.352819Z","end":"2026-09-30T02:26:21.47935Z","steps":["trace[631849994] 'process raft request' (duration: 122.919064ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:26:21.836063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.12679ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-30T02:26:21.836234Z","caller":"traceutil/trace.go:171","msg":"trace[663856069] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"126.040545ms","start":"2026-09-30T02:26:21.710171Z","end":"2026-09-30T02:26:21.836211Z","steps":["trace[663856069] 'process raft request' (duration: 21.667032ms)","trace[663856069] 'compare' (duration: 103.998347ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:26:24.992875Z","caller":"traceutil/trace.go:171","msg":"trace[1320854030] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"150.856173ms","start":"2026-09-30T02:26:24.841982Z","end":"2026-09-30T02:26:24.992838Z","steps":["trace[1320854030] 'process raft request' (duration: 150.541469ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:26:36.240429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.747652ms","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-30T02:26:36.240558Z","caller":"traceutil/trace.go:171","msg":"trace[582728816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5267; }","duration":"110.936776ms","start":"2026-09-30T02:26:36.129587Z","end":"2026-09-30T02:26:36.240524Z","steps":["trace[582728816] 'range keys from in-memory index tree' (duration: 110.532318ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:26:44.507122Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2856} {"level":"info","ts":"2026-09-30T02:26:44.592907Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2856,"took":"84.469ms","hash":3736700048,"current-db-size-bytes":52305920,"current-db-size":"52 MB","current-db-size-in-use-bytes":27721728,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-30T02:26:44.593007Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3736700048,"revision":2856,"compact-revision":-1} {"level":"warn","ts":"2026-09-30T02:30:54.079986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.797424ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-30T02:30:54.080074Z","caller":"traceutil/trace.go:171","msg":"trace[800308527] transaction","detail":"{read_only:false; response_revision:7106; number_of_response:1; }","duration":"128.661469ms","start":"2026-09-30T02:30:53.951398Z","end":"2026-09-30T02:30:54.080059Z","steps":["trace[800308527] 'process raft request' (duration: 22.719022ms)","trace[800308527] 'compare' (duration: 105.69936ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:31:44.513597Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5320} {"level":"info","ts":"2026-09-30T02:31:44.623709Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5320,"took":"108.512412ms","hash":4239187199,"current-db-size-bytes":52305920,"current-db-size":"52 MB","current-db-size-in-use-bytes":18935808,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-30T02:31:44.623772Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4239187199,"revision":5320,"compact-revision":2856}