{"level":"warn","ts":"2026-09-30T02:09:10.577986Z","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:09:10.578094Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.176: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.176:2380","--initial-cluster=instance=https://162.253.55.176:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.176:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.176: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:09:10.578242Z","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:09:10.578252Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-09-30T02:09:10.578325Z","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:09:10.57903Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"]} {"level":"info","ts":"2026-09-30T02:09:10.579145Z","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.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.176: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:09:10.583487Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.109899ms"} {"level":"info","ts":"2026-09-30T02:09:10.589984Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"590b810b00f00655","cluster-id":"dcc6923d0deac545"} {"level":"info","ts":"2026-09-30T02:09:10.590062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=()"} {"level":"info","ts":"2026-09-30T02:09:10.590182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 0"} {"level":"info","ts":"2026-09-30T02:09:10.590218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 590b810b00f00655 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-30T02:09:10.590225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 1"} {"level":"info","ts":"2026-09-30T02:09:10.590336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"warn","ts":"2026-09-30T02:09:10.601501Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-30T02:09:10.603034Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-30T02:09:10.606616Z","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:09:10.611027Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"590b810b00f00655","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-30T02:09:10.613764Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"590b810b00f00655","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-30T02:09:10.611416Z","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:09:10.614137Z","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:09:10.614197Z","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:09:10.614344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"info","ts":"2026-09-30T02:09:10.614571Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","added-peer-id":"590b810b00f00655","added-peer-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-09-30T02:09:10.618288Z","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:09:10.618461Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"590b810b00f00655","initial-advertise-peer-urls":["https://162.253.55.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-30T02:09:10.618507Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-30T02:09:10.618437Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-09-30T02:09:10.618588Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-09-30T02:09:11.49076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 is starting a new election at term 1"} {"level":"info","ts":"2026-09-30T02:09:11.490853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-30T02:09:11.490875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgPreVoteResp from 590b810b00f00655 at term 1"} {"level":"info","ts":"2026-09-30T02:09:11.491579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became candidate at term 2"} {"level":"info","ts":"2026-09-30T02:09:11.491596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgVoteResp from 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-09-30T02:09:11.491617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became leader at term 2"} {"level":"info","ts":"2026-09-30T02:09:11.491641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 590b810b00f00655 elected leader 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-09-30T02:09:11.492797Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T02:09:11.493808Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"590b810b00f00655","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.176:2379]}","request-path":"/0/members/590b810b00f00655/attributes","cluster-id":"dcc6923d0deac545","publish-timeout":"7s"} {"level":"info","ts":"2026-09-30T02:09:11.493997Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-30T02:09:11.494057Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-30T02:09:11.496444Z","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:09:11.496679Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T02:09:11.496767Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T02:09:11.496799Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-30T02:09:11.497392Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.176:2379"} {"level":"info","ts":"2026-09-30T02:09:11.500738Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-30T02:09:11.501018Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-30T02:10:00.08843Z","caller":"traceutil/trace.go:171","msg":"trace[50125643] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"106.94036ms","start":"2026-09-30T02:09:59.981468Z","end":"2026-09-30T02:10:00.088409Z","steps":["trace[50125643] 'process raft request' (duration: 106.815119ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:10:47.881306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.451848ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-30T02:10:47.881436Z","caller":"traceutil/trace.go:171","msg":"trace[1570253869] linearizableReadLoop","detail":"{readStateIndex:1217; appliedIndex:1216; }","duration":"103.329642ms","start":"2026-09-30T02:10:47.778089Z","end":"2026-09-30T02:10:47.881419Z","steps":["trace[1570253869] 'read index received' (duration: 73.441µs)","trace[1570253869] 'applied index is now lower than readState.Index' (duration: 103.254621ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:10:47.881506Z","caller":"traceutil/trace.go:171","msg":"trace[1818239961] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"230.516877ms","start":"2026-09-30T02:10:47.650954Z","end":"2026-09-30T02:10:47.881471Z","steps":["trace[1818239961] 'compare' (duration: 224.242285ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:10:47.881606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.513826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-30T02:10:47.881654Z","caller":"traceutil/trace.go:171","msg":"trace[1853193368] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1182; }","duration":"103.610256ms","start":"2026-09-30T02:10:47.77803Z","end":"2026-09-30T02:10:47.88164Z","steps":["trace[1853193368] 'agreement among raft nodes before linearized reading' (duration: 103.515255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:11:36.66355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.196033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-09-30T02:11:36.663638Z","caller":"traceutil/trace.go:171","msg":"trace[671680373] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1865; }","duration":"155.397228ms","start":"2026-09-30T02:11:36.508223Z","end":"2026-09-30T02:11:36.66362Z","steps":["trace[671680373] 'range keys from in-memory index tree' (duration: 155.017621ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:11:36.663752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.397065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bcd88736-fa3c-4950-9490-b81148a7fc81\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-30T02:11:36.663862Z","caller":"traceutil/trace.go:171","msg":"trace[558330637] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bcd88736-fa3c-4950-9490-b81148a7fc81; range_end:; response_count:1; response_revision:1865; }","duration":"211.550758ms","start":"2026-09-30T02:11:36.452279Z","end":"2026-09-30T02:11:36.66383Z","steps":["trace[558330637] 'range keys from in-memory index tree' (duration: 211.219471ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:11:37.134722Z","caller":"traceutil/trace.go:171","msg":"trace[563176847] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"352.072187ms","start":"2026-09-30T02:11:36.782625Z","end":"2026-09-30T02:11:37.134697Z","steps":["trace[563176847] 'process raft request' (duration: 351.715399ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:11:37.134875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:11:36.782598Z","time spent":"352.196109ms","remote":"127.0.0.1:43912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-30T02:11:37.135111Z","caller":"traceutil/trace.go:171","msg":"trace[1912813794] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"352.2773ms","start":"2026-09-30T02:11:36.78279Z","end":"2026-09-30T02:11:37.135068Z","steps":["trace[1912813794] 'process raft request' (duration: 351.864342ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:11:37.135251Z","caller":"traceutil/trace.go:171","msg":"trace[1147023387] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"352.329412ms","start":"2026-09-30T02:11:36.782909Z","end":"2026-09-30T02:11:37.135238Z","steps":["trace[1147023387] 'process raft request' (duration: 352.073186ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:11:37.135321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:11:36.782901Z","time spent":"352.386433ms","remote":"127.0.0.1:44008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-30T02:11:37.135331Z","caller":"traceutil/trace.go:171","msg":"trace[1308430358] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"352.172679ms","start":"2026-09-30T02:11:36.783122Z","end":"2026-09-30T02:11:37.135295Z","steps":["trace[1308430358] 'process raft request' (duration: 351.972165ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:11:37.135383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:11:36.782782Z","time spent":"352.493074ms","remote":"127.0.0.1:43912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-30T02:11:37.135409Z","caller":"traceutil/trace.go:171","msg":"trace[1670101346] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"352.194429ms","start":"2026-09-30T02:11:36.783195Z","end":"2026-09-30T02:11:37.13539Z","steps":["trace[1670101346] 'process raft request' (duration: 351.952244ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:11:37.135422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:11:36.783114Z","time spent":"352.26095ms","remote":"127.0.0.1:44016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-30T02:11:37.135394Z","caller":"traceutil/trace.go:171","msg":"trace[1901719452] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1936; }","duration":"233.306889ms","start":"2026-09-30T02:11:36.90203Z","end":"2026-09-30T02:11:37.135337Z","steps":["trace[1901719452] 'read index received' (duration: 232.216166ms)","trace[1901719452] 'applied index is now lower than readState.Index' (duration: 1.089853ms)"],"step_count":2} {"level":"warn","ts":"2026-09-30T02:11:37.135513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:11:36.783189Z","time spent":"352.25789ms","remote":"127.0.0.1:44016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-30T02:11:37.135433Z","caller":"traceutil/trace.go:171","msg":"trace[719526807] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"348.340313ms","start":"2026-09-30T02:11:36.787036Z","end":"2026-09-30T02:11:37.135376Z","steps":["trace[719526807] 'process raft request' (duration: 348.146229ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:11:37.1356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.570794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-30T02:11:37.13565Z","caller":"traceutil/trace.go:171","msg":"trace[8728783] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1873; }","duration":"233.624055ms","start":"2026-09-30T02:11:36.902013Z","end":"2026-09-30T02:11:37.135637Z","steps":["trace[8728783] 'agreement among raft nodes before linearized reading' (duration: 233.521613ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:11:37.135686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-30T02:11:36.787021Z","time spent":"348.610718ms","remote":"127.0.0.1:43938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-30T02:11:37.135859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.400147ms","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:11:37.139129Z","caller":"traceutil/trace.go:171","msg":"trace[531553072] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1873; }","duration":"136.696492ms","start":"2026-09-30T02:11:37.002376Z","end":"2026-09-30T02:11:37.139073Z","steps":["trace[531553072] 'agreement among raft nodes before linearized reading' (duration: 133.243753ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:12:05.223898Z","caller":"traceutil/trace.go:171","msg":"trace[1663772342] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"117.956981ms","start":"2026-09-30T02:12:05.105916Z","end":"2026-09-30T02:12:05.223873Z","steps":["trace[1663772342] 'process raft request' (duration: 105.225063ms)","trace[1663772342] 'compare' (duration: 12.616945ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:12:11.4391Z","caller":"traceutil/trace.go:171","msg":"trace[1660948005] linearizableReadLoop","detail":"{readStateIndex:2187; appliedIndex:2186; }","duration":"131.634131ms","start":"2026-09-30T02:12:11.307442Z","end":"2026-09-30T02:12:11.439077Z","steps":["trace[1660948005] 'read index received' (duration: 131.407406ms)","trace[1660948005] 'applied index is now lower than readState.Index' (duration: 225.795µs)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:12:11.439327Z","caller":"traceutil/trace.go:171","msg":"trace[1171120409] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"201.212896ms","start":"2026-09-30T02:12:11.238076Z","end":"2026-09-30T02:12:11.439289Z","steps":["trace[1171120409] 'process raft request' (duration: 200.850909ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:12:11.439364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.907646ms","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-30T02:12:11.43952Z","caller":"traceutil/trace.go:171","msg":"trace[1970577771] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2110; }","duration":"132.10782ms","start":"2026-09-30T02:12:11.307389Z","end":"2026-09-30T02:12:11.439497Z","steps":["trace[1970577771] 'agreement among raft nodes before linearized reading' (duration: 131.822533ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:12:12.134661Z","caller":"traceutil/trace.go:171","msg":"trace[1262189889] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"166.120307ms","start":"2026-09-30T02:12:11.968515Z","end":"2026-09-30T02:12:12.134635Z","steps":["trace[1262189889] 'process raft request' (duration: 117.093066ms)","trace[1262189889] 'compare' (duration: 48.852517ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:12:12.1351Z","caller":"traceutil/trace.go:171","msg":"trace[1285778106] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"164.035942ms","start":"2026-09-30T02:12:11.971052Z","end":"2026-09-30T02:12:12.135088Z","steps":["trace[1285778106] 'process raft request' (duration: 163.537962ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:12:12.289776Z","caller":"traceutil/trace.go:171","msg":"trace[311660657] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"149.821352ms","start":"2026-09-30T02:12:12.139914Z","end":"2026-09-30T02:12:12.289736Z","steps":["trace[311660657] 'process raft request' (duration: 94.967276ms)","trace[311660657] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/openstack/messaging-topology-operator-leader-election; req_size:552; } (duration: 54.532158ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:14:26.249366Z","caller":"traceutil/trace.go:171","msg":"trace[540686251] transaction","detail":"{read_only:false; response_revision:2933; number_of_response:1; }","duration":"101.748161ms","start":"2026-09-30T02:14:26.147587Z","end":"2026-09-30T02:14:26.249335Z","steps":["trace[540686251] 'process raft request' (duration: 101.582559ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:14:26.600701Z","caller":"traceutil/trace.go:171","msg":"trace[674223356] transaction","detail":"{read_only:false; response_revision:2935; number_of_response:1; }","duration":"108.629193ms","start":"2026-09-30T02:14:26.492046Z","end":"2026-09-30T02:14:26.600675Z","steps":["trace[674223356] 'process raft request' (duration: 82.371986ms)","trace[674223356] 'compare' (duration: 25.969273ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:14:26.610831Z","caller":"traceutil/trace.go:171","msg":"trace[945972260] transaction","detail":"{read_only:false; response_revision:2936; number_of_response:1; }","duration":"113.197871ms","start":"2026-09-30T02:14:26.497595Z","end":"2026-09-30T02:14:26.610793Z","steps":["trace[945972260] 'process raft request' (duration: 113.029579ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:11.52458Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2856} {"level":"info","ts":"2026-09-30T02:19:11.607897Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2856,"took":"81.572621ms","hash":1984454114,"current-db-size-bytes":51716096,"current-db-size":"52 MB","current-db-size-in-use-bytes":26550272,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-30T02:19:11.607964Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1984454114,"revision":2856,"compact-revision":-1} {"level":"info","ts":"2026-09-30T02:19:14.165093Z","caller":"traceutil/trace.go:171","msg":"trace[1824718158] transaction","detail":"{read_only:false; response_revision:5134; number_of_response:1; }","duration":"123.323395ms","start":"2026-09-30T02:19:14.041732Z","end":"2026-09-30T02:19:14.165055Z","steps":["trace[1824718158] 'process raft request' (duration: 120.784382ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:20.105356Z","caller":"traceutil/trace.go:171","msg":"trace[989547938] linearizableReadLoop","detail":"{readStateIndex:5376; appliedIndex:5375; }","duration":"226.47883ms","start":"2026-09-30T02:19:19.878846Z","end":"2026-09-30T02:19:20.105325Z","steps":["trace[989547938] 'read index received' (duration: 226.335187ms)","trace[989547938] 'applied index is now lower than readState.Index' (duration: 142.523µs)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:19:20.105415Z","caller":"traceutil/trace.go:171","msg":"trace[1669631627] transaction","detail":"{read_only:false; response_revision:5180; number_of_response:1; }","duration":"235.651845ms","start":"2026-09-30T02:19:19.869728Z","end":"2026-09-30T02:19:20.10538Z","steps":["trace[1669631627] 'process raft request' (duration: 235.401999ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:19:20.10564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.762326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-09-30T02:19:20.105687Z","caller":"traceutil/trace.go:171","msg":"trace[1702020640] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5180; }","duration":"226.882179ms","start":"2026-09-30T02:19:19.878791Z","end":"2026-09-30T02:19:20.105673Z","steps":["trace[1702020640] 'agreement among raft nodes before linearized reading' (duration: 226.672154ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:20.162378Z","caller":"traceutil/trace.go:171","msg":"trace[44570312] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"130.93959ms","start":"2026-09-30T02:19:20.031391Z","end":"2026-09-30T02:19:20.162331Z","steps":["trace[44570312] 'process raft request' (duration: 130.797937ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:19:20.162482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.522227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-744f56b88b-gg2jg.18d9f7c68535afb2\" ","response":"range_response_count:1 size:894"} {"level":"warn","ts":"2026-09-30T02:19:20.162541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.734905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-30T02:19:20.16256Z","caller":"traceutil/trace.go:171","msg":"trace[1003828850] transaction","detail":"{read_only:false; response_revision:5181; number_of_response:1; }","duration":"131.114704ms","start":"2026-09-30T02:19:20.031392Z","end":"2026-09-30T02:19:20.162507Z","steps":["trace[1003828850] 'process raft request' (duration: 130.566372ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:20.162598Z","caller":"traceutil/trace.go:171","msg":"trace[988210556] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-744f56b88b-gg2jg.18d9f7c68535afb2; range_end:; response_count:1; response_revision:5182; }","duration":"283.705891ms","start":"2026-09-30T02:19:19.878865Z","end":"2026-09-30T02:19:20.162571Z","steps":["trace[988210556] 'agreement among raft nodes before linearized reading' (duration: 283.387944ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:20.162626Z","caller":"traceutil/trace.go:171","msg":"trace[1502733773] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5182; }","duration":"242.96734ms","start":"2026-09-30T02:19:19.919633Z","end":"2026-09-30T02:19:20.162601Z","steps":["trace[1502733773] 'agreement among raft nodes before linearized reading' (duration: 242.709624ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:19:20.162655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.897463ms","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-30T02:19:20.162751Z","caller":"traceutil/trace.go:171","msg":"trace[282104261] 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:5182; }","duration":"264.012115ms","start":"2026-09-30T02:19:19.898713Z","end":"2026-09-30T02:19:20.162725Z","steps":["trace[282104261] 'agreement among raft nodes before linearized reading' (duration: 263.696388ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:19:49.282516Z","caller":"traceutil/trace.go:171","msg":"trace[251634993] transaction","detail":"{read_only:false; response_revision:5488; number_of_response:1; }","duration":"129.912727ms","start":"2026-09-30T02:19:49.152571Z","end":"2026-09-30T02:19:49.282483Z","steps":["trace[251634993] 'process raft request' (duration: 129.725783ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:21:20.442737Z","caller":"traceutil/trace.go:171","msg":"trace[1370239442] transaction","detail":"{read_only:false; response_revision:6184; number_of_response:1; }","duration":"160.73261ms","start":"2026-09-30T02:21:20.281968Z","end":"2026-09-30T02:21:20.442701Z","steps":["trace[1370239442] 'process raft request' (duration: 160.533496ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:21:20.475049Z","caller":"traceutil/trace.go:171","msg":"trace[1040907946] linearizableReadLoop","detail":"{readStateIndex:6411; appliedIndex:6409; }","duration":"129.729221ms","start":"2026-09-30T02:21:20.345291Z","end":"2026-09-30T02:21:20.47502Z","steps":["trace[1040907946] 'read index received' (duration: 97.21124ms)","trace[1040907946] 'applied index is now lower than readState.Index' (duration: 32.516741ms)"],"step_count":2} {"level":"info","ts":"2026-09-30T02:21:20.475278Z","caller":"traceutil/trace.go:171","msg":"trace[1724928395] transaction","detail":"{read_only:false; response_revision:6185; number_of_response:1; }","duration":"193.013897ms","start":"2026-09-30T02:21:20.282072Z","end":"2026-09-30T02:21:20.475086Z","steps":["trace[1724928395] 'process raft request' (duration: 192.783972ms)"],"step_count":1} {"level":"warn","ts":"2026-09-30T02:21:20.475513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.083179ms","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-30T02:21:20.475568Z","caller":"traceutil/trace.go:171","msg":"trace[1647608624] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6185; }","duration":"130.291693ms","start":"2026-09-30T02:21:20.345263Z","end":"2026-09-30T02:21:20.475554Z","steps":["trace[1647608624] 'agreement among raft nodes before linearized reading' (duration: 129.865064ms)"],"step_count":1} {"level":"info","ts":"2026-09-30T02:24:11.530884Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5074} {"level":"info","ts":"2026-09-30T02:24:11.60735Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5074,"took":"74.429107ms","hash":313498757,"current-db-size-bytes":51716096,"current-db-size":"52 MB","current-db-size-in-use-bytes":19505152,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-09-30T02:24:11.607438Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":313498757,"revision":5074,"compact-revision":2856}