{"level":"warn","ts":"2026-09-22T01:49:09.687935Z","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-22T01:49:09.688014Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.223: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.223:2380","--initial-cluster=instance=https://162.253.55.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.223: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-22T01:49:09.688069Z","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-22T01:49:09.688081Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-09-22T01:49:09.688096Z","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-22T01:49:09.688709Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"]} {"level":"info","ts":"2026-09-22T01:49:09.688791Z","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.223:2380"],"listen-peer-urls":["https://162.253.55.223:2380"],"advertise-client-urls":["https://162.253.55.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.223: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-22T01:49:09.694294Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.288294ms"} {"level":"info","ts":"2026-09-22T01:49:09.704833Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a0f50f8a6c5f7d06","cluster-id":"62f129f77cf8e487"} {"level":"info","ts":"2026-09-22T01:49:09.704924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T01:49:09.704948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 0"} {"level":"info","ts":"2026-09-22T01:49:09.704988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a0f50f8a6c5f7d06 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T01:49:09.70501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 1"} {"level":"info","ts":"2026-09-22T01:49:09.705058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"warn","ts":"2026-09-22T01:49:09.714361Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T01:49:09.717644Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T01:49:09.719119Z","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-22T01:49:09.725652Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a0f50f8a6c5f7d06","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T01:49:09.726194Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a0f50f8a6c5f7d06","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T01:49:09.726245Z","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-22T01:49:09.726271Z","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-22T01:49:09.726278Z","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-22T01:49:09.729508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"info","ts":"2026-09-22T01:49:09.729708Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62f129f77cf8e487","local-member-id":"a0f50f8a6c5f7d06","added-peer-id":"a0f50f8a6c5f7d06","added-peer-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-09-22T01:49:09.731515Z","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-22T01:49:09.732104Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-09-22T01:49:09.732176Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-09-22T01:49:09.731706Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a0f50f8a6c5f7d06","initial-advertise-peer-urls":["https://162.253.55.223:2380"],"listen-peer-urls":["https://162.253.55.223:2380"],"advertise-client-urls":["https://162.253.55.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T01:49:09.732777Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T01:49:10.405549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T01:49:10.405618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T01:49:10.405653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgPreVoteResp from a0f50f8a6c5f7d06 at term 1"} {"level":"info","ts":"2026-09-22T01:49:10.405689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became candidate at term 2"} {"level":"info","ts":"2026-09-22T01:49:10.405705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgVoteResp from a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-09-22T01:49:10.40572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became leader at term 2"} {"level":"info","ts":"2026-09-22T01:49:10.405737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a0f50f8a6c5f7d06 elected leader a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-09-22T01:49:10.407209Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:49:10.40923Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62f129f77cf8e487","local-member-id":"a0f50f8a6c5f7d06","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:49:10.409323Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:49:10.409356Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:49:10.409372Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T01:49:10.409382Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T01:49:10.40947Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a0f50f8a6c5f7d06","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.223:2379]}","request-path":"/0/members/a0f50f8a6c5f7d06/attributes","cluster-id":"62f129f77cf8e487","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T01:49:10.412509Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.223:2379"} {"level":"info","ts":"2026-09-22T01:49:10.412644Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T01:49:10.41269Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T01:49:10.413217Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-22T01:49:36.471284Z","caller":"traceutil/trace.go:171","msg":"trace[1621454397] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"104.490211ms","start":"2026-09-22T01:49:36.366734Z","end":"2026-09-22T01:49:36.471224Z","steps":["trace[1621454397] 'process raft request' (duration: 104.305607ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:52.092121Z","caller":"traceutil/trace.go:171","msg":"trace[955028257] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"156.077878ms","start":"2026-09-22T01:49:51.935997Z","end":"2026-09-22T01:49:52.092075Z","steps":["trace[955028257] 'process raft request' (duration: 155.881344ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:52.091975Z","caller":"traceutil/trace.go:171","msg":"trace[811841667] transaction","detail":"{read_only:false; number_of_response:0; response_revision:513; }","duration":"162.712261ms","start":"2026-09-22T01:49:51.929243Z","end":"2026-09-22T01:49:52.091956Z","steps":["trace[811841667] 'process raft request' (duration: 162.462766ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:52.092336Z","caller":"traceutil/trace.go:171","msg":"trace[450425035] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"154.207264ms","start":"2026-09-22T01:49:51.93806Z","end":"2026-09-22T01:49:52.092267Z","steps":["trace[450425035] 'process raft request' (duration: 153.931109ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:52.098934Z","caller":"traceutil/trace.go:171","msg":"trace[67244073] transaction","detail":"{read_only:false; number_of_response:0; response_revision:516; }","duration":"149.861814ms","start":"2026-09-22T01:49:51.949045Z","end":"2026-09-22T01:49:52.098907Z","steps":["trace[67244073] 'process raft request' (duration: 149.539438ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:52.099231Z","caller":"traceutil/trace.go:171","msg":"trace[793007907] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"154.450808ms","start":"2026-09-22T01:49:51.94477Z","end":"2026-09-22T01:49:52.099221Z","steps":["trace[793007907] 'process raft request' (duration: 153.623733ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:52.099524Z","caller":"traceutil/trace.go:171","msg":"trace[451182088] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"150.050008ms","start":"2026-09-22T01:49:51.949465Z","end":"2026-09-22T01:49:52.099515Z","steps":["trace[451182088] 'process raft request' (duration: 149.182851ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:52.100857Z","caller":"traceutil/trace.go:171","msg":"trace[424603304] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"148.519938ms","start":"2026-09-22T01:49:51.952324Z","end":"2026-09-22T01:49:52.100844Z","steps":["trace[424603304] 'process raft request' (duration: 148.244333ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:52.100972Z","caller":"traceutil/trace.go:171","msg":"trace[1742912614] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"147.201594ms","start":"2026-09-22T01:49:51.953765Z","end":"2026-09-22T01:49:52.100966Z","steps":["trace[1742912614] 'process raft request' (duration: 146.841287ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:52.101058Z","caller":"traceutil/trace.go:171","msg":"trace[315924171] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"134.045692ms","start":"2026-09-22T01:49:51.967008Z","end":"2026-09-22T01:49:52.101053Z","steps":["trace[315924171] 'process raft request' (duration: 133.644275ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:52.100835Z","caller":"traceutil/trace.go:171","msg":"trace[1207088002] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"151.281469ms","start":"2026-09-22T01:49:51.949533Z","end":"2026-09-22T01:49:52.100815Z","steps":["trace[1207088002] 'process raft request' (duration: 149.225112ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:58.951058Z","caller":"traceutil/trace.go:171","msg":"trace[2096904265] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"230.901823ms","start":"2026-09-22T01:49:58.720115Z","end":"2026-09-22T01:49:58.951017Z","steps":["trace[2096904265] 'process raft request' (duration: 230.681919ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:49:59.041066Z","caller":"traceutil/trace.go:171","msg":"trace[371534604] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"320.440834ms","start":"2026-09-22T01:49:58.72059Z","end":"2026-09-22T01:49:59.041031Z","steps":["trace[371534604] 'process raft request' (duration: 308.691228ms)","trace[371534604] 'compare' (duration: 11.42614ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:49:59.04165Z","caller":"traceutil/trace.go:171","msg":"trace[475339843] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"180.494043ms","start":"2026-09-22T01:49:58.861128Z","end":"2026-09-22T01:49:59.041623Z","steps":["trace[475339843] 'process raft request' (duration: 179.950803ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:49:59.041825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:49:58.720566Z","time spent":"320.575447ms","remote":"127.0.0.1:58782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:49:59.62646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.479975ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:49:59.627485Z","caller":"traceutil/trace.go:171","msg":"trace[1445422478] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"526.120323ms","start":"2026-09-22T01:49:59.101311Z","end":"2026-09-22T01:49:59.627432Z","steps":["trace[1445422478] 'process raft request' (duration: 335.146882ms)","trace[1445422478] 'compare' (duration: 189.358813ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:49:59.627642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:49:59.101241Z","time spent":"526.311036ms","remote":"127.0.0.1:58698","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-22T01:49:59.62806Z","caller":"traceutil/trace.go:171","msg":"trace[1056320954] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"515.838083ms","start":"2026-09-22T01:49:59.111823Z","end":"2026-09-22T01:49:59.627661Z","steps":["trace[1056320954] 'process raft request' (duration: 515.377035ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:49:59.628318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:49:59.111807Z","time spent":"516.384143ms","remote":"127.0.0.1:58752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T01:49:59.644578Z","caller":"traceutil/trace.go:171","msg":"trace[1627847186] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:633; }","duration":"319.756104ms","start":"2026-09-22T01:49:59.324756Z","end":"2026-09-22T01:49:59.644512Z","steps":["trace[1627847186] 'read index received' (duration: 111.713625ms)","trace[1627847186] 'applied index is now lower than readState.Index' (duration: 208.040199ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:49:59.644978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.082988ms","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-22T01:49:59.645072Z","caller":"traceutil/trace.go:171","msg":"trace[1397217489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"320.372494ms","start":"2026-09-22T01:49:59.324676Z","end":"2026-09-22T01:49:59.645048Z","steps":["trace[1397217489] 'agreement among raft nodes before linearized reading' (duration: 319.960957ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:49:59.645128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:49:59.324651Z","time spent":"320.458535ms","remote":"127.0.0.1:58782","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-22T01:51:32.418877Z","caller":"traceutil/trace.go:171","msg":"trace[1747655591] linearizableReadLoop","detail":"{readStateIndex:1909; appliedIndex:1908; }","duration":"256.026404ms","start":"2026-09-22T01:51:32.162825Z","end":"2026-09-22T01:51:32.418852Z","steps":["trace[1747655591] 'read index received' (duration: 255.820201ms)","trace[1747655591] 'applied index is now lower than readState.Index' (duration: 205.332µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:32.418921Z","caller":"traceutil/trace.go:171","msg":"trace[973037049] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"286.482471ms","start":"2026-09-22T01:51:32.132413Z","end":"2026-09-22T01:51:32.418895Z","steps":["trace[973037049] 'process raft request' (duration: 286.293649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:32.419061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.228976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:51:32.419133Z","caller":"traceutil/trace.go:171","msg":"trace[770606351] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1835; }","duration":"256.365158ms","start":"2026-09-22T01:51:32.162748Z","end":"2026-09-22T01:51:32.419113Z","steps":["trace[770606351] 'agreement among raft nodes before linearized reading' (duration: 256.239686ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:32.41979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.290987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T01:51:32.419856Z","caller":"traceutil/trace.go:171","msg":"trace[1134378077] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1835; }","duration":"118.391018ms","start":"2026-09-22T01:51:32.301448Z","end":"2026-09-22T01:51:32.419839Z","steps":["trace[1134378077] 'agreement among raft nodes before linearized reading' (duration: 117.640659ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:32.548538Z","caller":"traceutil/trace.go:171","msg":"trace[1885209074] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"124.1762ms","start":"2026-09-22T01:51:32.424305Z","end":"2026-09-22T01:51:32.548481Z","steps":["trace[1885209074] 'process raft request' (duration: 86.100208ms)","trace[1885209074] 'compare' (duration: 37.848919ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:32.691838Z","caller":"traceutil/trace.go:171","msg":"trace[1673616853] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"115.652424ms","start":"2026-09-22T01:51:32.576147Z","end":"2026-09-22T01:51:32.691799Z","steps":["trace[1673616853] 'process raft request' (duration: 72.973525ms)","trace[1673616853] 'compare' (duration: 42.193623ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:32.953354Z","caller":"traceutil/trace.go:171","msg":"trace[1356991454] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"256.527481ms","start":"2026-09-22T01:51:32.696762Z","end":"2026-09-22T01:51:32.953289Z","steps":["trace[1356991454] 'process raft request' (duration: 181.39899ms)","trace[1356991454] 'compare' (duration: 74.22123ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:32.953879Z","caller":"traceutil/trace.go:171","msg":"trace[1374236394] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"236.555993ms","start":"2026-09-22T01:51:32.717283Z","end":"2026-09-22T01:51:32.953839Z","steps":["trace[1374236394] 'process raft request' (duration: 236.31747ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:02.965918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-22T01:52:02.966557Z","caller":"traceutil/trace.go:171","msg":"trace[289753577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2058; }","duration":"236.620967ms","start":"2026-09-22T01:52:02.729907Z","end":"2026-09-22T01:52:02.966528Z","steps":["trace[289753577] 'range keys from in-memory index tree' (duration: 234.940707ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:03.246083Z","caller":"traceutil/trace.go:171","msg":"trace[2136098769] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"168.457229ms","start":"2026-09-22T01:52:03.077565Z","end":"2026-09-22T01:52:03.246022Z","steps":["trace[2136098769] 'process raft request' (duration: 167.756631ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:52:03.250272Z","caller":"traceutil/trace.go:171","msg":"trace[1200690389] linearizableReadLoop","detail":"{readStateIndex:2142; appliedIndex:2140; }","duration":"162.499259ms","start":"2026-09-22T01:52:03.087738Z","end":"2026-09-22T01:52:03.250237Z","steps":["trace[1200690389] 'read index received' (duration: 157.597581ms)","trace[1200690389] 'applied index is now lower than readState.Index' (duration: 4.900068ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:52:03.250416Z","caller":"traceutil/trace.go:171","msg":"trace[129374221] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"172.745209ms","start":"2026-09-22T01:52:03.077631Z","end":"2026-09-22T01:52:03.250376Z","steps":["trace[129374221] 'process raft request' (duration: 172.416605ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:52:03.250543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.772212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-22T01:52:03.250587Z","caller":"traceutil/trace.go:171","msg":"trace[130553974] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2061; }","duration":"162.880894ms","start":"2026-09-22T01:52:03.087691Z","end":"2026-09-22T01:52:03.250571Z","steps":["trace[130553974] 'agreement among raft nodes before linearized reading' (duration: 162.667151ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:12.168208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.468215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-22T01:58:12.168269Z","caller":"traceutil/trace.go:171","msg":"trace[1368014599] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4730; }","duration":"104.560057ms","start":"2026-09-22T01:58:12.063697Z","end":"2026-09-22T01:58:12.168257Z","steps":["trace[1368014599] 'range keys from in-memory index tree' (duration: 104.378204ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:12.168272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.849092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:7 size:60733"} {"level":"info","ts":"2026-09-22T01:58:12.168325Z","caller":"traceutil/trace.go:171","msg":"trace[2046656549] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:7; response_revision:4730; }","duration":"104.947773ms","start":"2026-09-22T01:58:12.063365Z","end":"2026-09-22T01:58:12.168313Z","steps":["trace[2046656549] 'range keys from in-memory index tree' (duration: 104.693399ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:24.886538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.311326ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:58:24.886733Z","caller":"traceutil/trace.go:171","msg":"trace[941381037] linearizableReadLoop","detail":"{readStateIndex:5112; appliedIndex:5111; }","duration":"288.901729ms","start":"2026-09-22T01:58:24.597813Z","end":"2026-09-22T01:58:24.886715Z","steps":["trace[941381037] 'read index received' (duration: 141.196607ms)","trace[941381037] 'applied index is now lower than readState.Index' (duration: 147.703482ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:58:24.886908Z","caller":"traceutil/trace.go:171","msg":"trace[1078216963] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"290.860272ms","start":"2026-09-22T01:58:24.596033Z","end":"2026-09-22T01:58:24.886893Z","steps":["trace[1078216963] 'process raft request' (duration: 143.034608ms)","trace[1078216963] 'compare' (duration: 147.087083ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:58:24.887249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.385097ms","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-22T01:58:24.88734Z","caller":"traceutil/trace.go:171","msg":"trace[1996008526] 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:4920; }","duration":"289.508989ms","start":"2026-09-22T01:58:24.597809Z","end":"2026-09-22T01:58:24.887318Z","steps":["trace[1996008526] 'agreement among raft nodes before linearized reading' (duration: 289.205104ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.268763Z","caller":"traceutil/trace.go:171","msg":"trace[1702686570] linearizableReadLoop","detail":"{readStateIndex:5115; appliedIndex:5112; }","duration":"381.889742ms","start":"2026-09-22T01:58:24.886831Z","end":"2026-09-22T01:58:25.268721Z","steps":["trace[1702686570] 'read index received' (duration: 344.275977ms)","trace[1702686570] 'applied index is now lower than readState.Index' (duration: 37.612935ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:58:25.269109Z","caller":"traceutil/trace.go:171","msg":"trace[1622285828] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"662.112423ms","start":"2026-09-22T01:58:24.60698Z","end":"2026-09-22T01:58:25.269092Z","steps":["trace[1622285828] 'process raft request' (duration: 624.184623ms)","trace[1622285828] 'compare' (duration: 37.370981ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:58:25.269338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.378596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-22T01:58:25.26942Z","caller":"traceutil/trace.go:171","msg":"trace[1369300884] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4923; }","duration":"596.519249ms","start":"2026-09-22T01:58:24.672882Z","end":"2026-09-22T01:58:25.269401Z","steps":["trace[1369300884] 'agreement among raft nodes before linearized reading' (duration: 596.300125ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.269484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:24.672854Z","time spent":"596.59328ms","remote":"127.0.0.1:58698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-09-22T01:58:25.269158Z","caller":"traceutil/trace.go:171","msg":"trace[1427367112] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"572.761198ms","start":"2026-09-22T01:58:24.696389Z","end":"2026-09-22T01:58:25.26915Z","steps":["trace[1427367112] 'process raft request' (duration: 572.29836ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.269443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:24.606941Z","time spent":"662.340526ms","remote":"127.0.0.1:58698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13280,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:58:25.269685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:24.696364Z","time spent":"573.224395ms","remote":"127.0.0.1:58782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:58:25.269717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.665269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-22T01:58:25.269182Z","caller":"traceutil/trace.go:171","msg":"trace[527664509] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"573.60174ms","start":"2026-09-22T01:58:24.695574Z","end":"2026-09-22T01:58:25.269175Z","steps":["trace[527664509] 'process raft request' (duration: 573.065681ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.269795Z","caller":"traceutil/trace.go:171","msg":"trace[572136016] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4923; }","duration":"660.816771ms","start":"2026-09-22T01:58:24.608959Z","end":"2026-09-22T01:58:25.269776Z","steps":["trace[572136016] 'agreement among raft nodes before linearized reading' (duration: 660.235521ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.269843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:24.608947Z","time spent":"660.887503ms","remote":"127.0.0.1:58782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-22T01:58:25.269998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:24.695546Z","time spent":"574.345491ms","remote":"127.0.0.1:58782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:58:25.27055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.762166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-68a27c72-9fb6-4eae-97b4-b76fec8c1765\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-09-22T01:58:25.270596Z","caller":"traceutil/trace.go:171","msg":"trace[1750871209] range","detail":"{range_begin:/registry/persistentvolumes/pvc-68a27c72-9fb6-4eae-97b4-b76fec8c1765; range_end:; response_count:1; response_revision:4925; }","duration":"379.810027ms","start":"2026-09-22T01:58:24.890774Z","end":"2026-09-22T01:58:25.270584Z","steps":["trace[1750871209] 'agreement among raft nodes before linearized reading' (duration: 379.663675ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.270622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:24.890699Z","time spent":"379.916949ms","remote":"127.0.0.1:58658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1473,"request content":"key:\"/registry/persistentvolumes/pvc-68a27c72-9fb6-4eae-97b4-b76fec8c1765\" "} {"level":"info","ts":"2026-09-22T01:58:25.270874Z","caller":"traceutil/trace.go:171","msg":"trace[146103868] transaction","detail":"{read_only:false; response_revision:4924; number_of_response:1; }","duration":"377.228076ms","start":"2026-09-22T01:58:24.893634Z","end":"2026-09-22T01:58:25.270862Z","steps":["trace[146103868] 'process raft request' (duration: 376.660016ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.27095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:24.893613Z","time spent":"377.293936ms","remote":"127.0.0.1:58594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T01:58:25.271157Z","caller":"traceutil/trace.go:171","msg":"trace[850281545] transaction","detail":"{read_only:false; response_revision:4925; number_of_response:1; }","duration":"125.808759ms","start":"2026-09-22T01:58:25.145338Z","end":"2026-09-22T01:58:25.271147Z","steps":["trace[850281545] 'process raft request' (duration: 125.042907ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.271576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.71194ms","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-22T01:58:25.271619Z","caller":"traceutil/trace.go:171","msg":"trace[1874724719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4925; }","duration":"373.792671ms","start":"2026-09-22T01:58:24.897815Z","end":"2026-09-22T01:58:25.271607Z","steps":["trace[1874724719] 'agreement among raft nodes before linearized reading' (duration: 373.685159ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.271646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:24.897798Z","time spent":"373.841691ms","remote":"127.0.0.1:58782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-22T01:58:25.511918Z","caller":"traceutil/trace.go:171","msg":"trace[1486463238] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"234.231309ms","start":"2026-09-22T01:58:25.277662Z","end":"2026-09-22T01:58:25.511893Z","steps":["trace[1486463238] 'process raft request' (duration: 234.097647ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.51198Z","caller":"traceutil/trace.go:171","msg":"trace[861824655] linearizableReadLoop","detail":"{readStateIndex:5121; appliedIndex:5117; }","duration":"234.092206ms","start":"2026-09-22T01:58:25.277871Z","end":"2026-09-22T01:58:25.511963Z","steps":["trace[861824655] 'read index received' (duration: 25.539ms)","trace[861824655] 'applied index is now lower than readState.Index' (duration: 208.552226ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:58:25.512071Z","caller":"traceutil/trace.go:171","msg":"trace[2094344186] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"234.347211ms","start":"2026-09-22T01:58:25.277715Z","end":"2026-09-22T01:58:25.512062Z","steps":["trace[2094344186] 'process raft request' (duration: 234.100287ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.512258Z","caller":"traceutil/trace.go:171","msg":"trace[1641313473] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"226.399954ms","start":"2026-09-22T01:58:25.285847Z","end":"2026-09-22T01:58:25.512247Z","steps":["trace[1641313473] 'process raft request' (duration: 226.080339ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.512346Z","caller":"traceutil/trace.go:171","msg":"trace[697475887] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"226.719419ms","start":"2026-09-22T01:58:25.2856Z","end":"2026-09-22T01:58:25.51232Z","steps":["trace[697475887] 'process raft request' (duration: 226.246521ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.512146Z","caller":"traceutil/trace.go:171","msg":"trace[1074691554] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"234.602985ms","start":"2026-09-22T01:58:25.27753Z","end":"2026-09-22T01:58:25.512133Z","steps":["trace[1074691554] 'process raft request' (duration: 137.380405ms)","trace[1074691554] 'compare' (duration: 96.653811ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:58:25.51241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.345326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T01:58:25.512489Z","caller":"traceutil/trace.go:171","msg":"trace[662199726] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4932; }","duration":"200.443757ms","start":"2026-09-22T01:58:25.312005Z","end":"2026-09-22T01:58:25.512449Z","steps":["trace[662199726] 'agreement among raft nodes before linearized reading' (duration: 200.344226ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.512375Z","caller":"traceutil/trace.go:171","msg":"trace[1475573874] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"226.539206ms","start":"2026-09-22T01:58:25.285774Z","end":"2026-09-22T01:58:25.512313Z","steps":["trace[1475573874] 'process raft request' (duration: 226.110259ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.512698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.809318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-09-22T01:58:25.512758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.84902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-09-22T01:58:25.512779Z","caller":"traceutil/trace.go:171","msg":"trace[1694501477] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4932; }","duration":"234.92041ms","start":"2026-09-22T01:58:25.277848Z","end":"2026-09-22T01:58:25.512768Z","steps":["trace[1694501477] 'agreement among raft nodes before linearized reading' (duration: 234.728577ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.512794Z","caller":"traceutil/trace.go:171","msg":"trace[814393762] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4932; }","duration":"115.943091ms","start":"2026-09-22T01:58:25.39684Z","end":"2026-09-22T01:58:25.512784Z","steps":["trace[814393762] 'agreement among raft nodes before linearized reading' (duration: 115.808998ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.657942Z","caller":"traceutil/trace.go:171","msg":"trace[283920371] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"137.006059ms","start":"2026-09-22T01:58:25.520896Z","end":"2026-09-22T01:58:25.657902Z","steps":["trace[283920371] 'process raft request' (duration: 108.418539ms)","trace[283920371] 'compare' (duration: 28.395027ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:58:25.875806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.135709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:58:25.875903Z","caller":"traceutil/trace.go:171","msg":"trace[733296203] linearizableReadLoop","detail":"{readStateIndex:5126; appliedIndex:5125; }","duration":"211.014747ms","start":"2026-09-22T01:58:25.664872Z","end":"2026-09-22T01:58:25.875886Z","steps":["trace[733296203] 'read index received' (duration: 108.725446ms)","trace[733296203] 'applied index is now lower than readState.Index' (duration: 102.288041ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:58:25.876113Z","caller":"traceutil/trace.go:171","msg":"trace[32416846] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"212.278647ms","start":"2026-09-22T01:58:25.663804Z","end":"2026-09-22T01:58:25.876082Z","steps":["trace[32416846] 'process raft request' (duration: 109.780723ms)","trace[32416846] 'compare' (duration: 101.954675ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:58:25.876159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.279531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:58:25.876191Z","caller":"traceutil/trace.go:171","msg":"trace[1581578940] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4934; }","duration":"211.351173ms","start":"2026-09-22T01:58:25.664829Z","end":"2026-09-22T01:58:25.87618Z","steps":["trace[1581578940] 'agreement among raft nodes before linearized reading' (duration: 211.281472ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.907885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.697117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T01:58:25.907944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.309607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-22T01:58:25.907962Z","caller":"traceutil/trace.go:171","msg":"trace[997527766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4935; }","duration":"148.830529ms","start":"2026-09-22T01:58:25.759113Z","end":"2026-09-22T01:58:25.907944Z","steps":["trace[997527766] 'agreement among raft nodes before linearized reading' (duration: 148.653756ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.907992Z","caller":"traceutil/trace.go:171","msg":"trace[958630913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4935; }","duration":"230.398239ms","start":"2026-09-22T01:58:25.67758Z","end":"2026-09-22T01:58:25.907978Z","steps":["trace[958630913] 'agreement among raft nodes before linearized reading' (duration: 230.230506ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.907981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.150814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-22T01:58:25.908045Z","caller":"traceutil/trace.go:171","msg":"trace[1844221803] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4935; }","duration":"225.242216ms","start":"2026-09-22T01:58:25.682787Z","end":"2026-09-22T01:58:25.90803Z","steps":["trace[1844221803] 'agreement among raft nodes before linearized reading' (duration: 225.003812ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:25.908212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.332036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-22T01:58:25.908245Z","caller":"traceutil/trace.go:171","msg":"trace[466772696] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4935; }","duration":"230.383977ms","start":"2026-09-22T01:58:25.677848Z","end":"2026-09-22T01:58:25.908232Z","steps":["trace[466772696] 'agreement among raft nodes before linearized reading' (duration: 230.297616ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:25.908347Z","caller":"traceutil/trace.go:171","msg":"trace[852732081] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"234.188689ms","start":"2026-09-22T01:58:25.674145Z","end":"2026-09-22T01:58:25.908333Z","steps":["trace[852732081] 'process raft request' (duration: 233.456697ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:43.554833Z","caller":"traceutil/trace.go:171","msg":"trace[1660395949] transaction","detail":"{read_only:false; response_revision:5164; number_of_response:1; }","duration":"113.629067ms","start":"2026-09-22T01:58:43.441156Z","end":"2026-09-22T01:58:43.554785Z","steps":["trace[1660395949] 'process raft request' (duration: 47.196217ms)","trace[1660395949] 'compare' (duration: 66.319349ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:58:53.974287Z","caller":"traceutil/trace.go:171","msg":"trace[385327457] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"108.421823ms","start":"2026-09-22T01:58:53.865843Z","end":"2026-09-22T01:58:53.974265Z","steps":["trace[385327457] 'process raft request' (duration: 73.711728ms)","trace[385327457] 'compare' (duration: 34.530802ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:58:53.974636Z","caller":"traceutil/trace.go:171","msg":"trace[82606517] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"108.725129ms","start":"2026-09-22T01:58:53.865882Z","end":"2026-09-22T01:58:53.974607Z","steps":["trace[82606517] 'process raft request' (duration: 108.327172ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:53.974686Z","caller":"traceutil/trace.go:171","msg":"trace[156737134] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"108.519645ms","start":"2026-09-22T01:58:53.86614Z","end":"2026-09-22T01:58:53.97466Z","steps":["trace[156737134] 'process raft request' (duration: 108.369083ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:59:10.63329Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2854} {"level":"info","ts":"2026-09-22T01:59:10.713398Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2854,"took":"79.056469ms","hash":3364437078,"current-db-size-bytes":52600832,"current-db-size":"53 MB","current-db-size-in-use-bytes":27570176,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-22T01:59:10.713471Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3364437078,"revision":2854,"compact-revision":-1} {"level":"info","ts":"2026-09-22T02:02:50.884294Z","caller":"traceutil/trace.go:171","msg":"trace[520806304] transaction","detail":"{read_only:false; response_revision:6966; number_of_response:1; }","duration":"127.067896ms","start":"2026-09-22T02:02:50.757198Z","end":"2026-09-22T02:02:50.884266Z","steps":["trace[520806304] 'process raft request' (duration: 126.87283ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:10.63965Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5357} {"level":"info","ts":"2026-09-22T02:04:10.720303Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5357,"took":"79.434203ms","hash":2233095602,"current-db-size-bytes":52600832,"current-db-size":"53 MB","current-db-size-in-use-bytes":18538496,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-09-22T02:04:10.720367Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2233095602,"revision":5357,"compact-revision":2854}