{"level":"warn","ts":"2026-09-07T03:25:22.940713Z","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-07T03:25:22.940849Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.121: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.121:2380","--initial-cluster=instance=https://162.253.55.121:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.121:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.121: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-07T03:25:22.941178Z","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-07T03:25:22.94122Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.121:2380"]} {"level":"info","ts":"2026-09-07T03:25:22.94126Z","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-07T03:25:22.942341Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.121:2379"]} {"level":"info","ts":"2026-09-07T03:25:22.942483Z","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.121:2380"],"listen-peer-urls":["https://162.253.55.121:2380"],"advertise-client-urls":["https://162.253.55.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.121: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-07T03:25:22.953086Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.23097ms"} {"level":"info","ts":"2026-09-07T03:25:22.967625Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e064f6438c9a029d","cluster-id":"46d59d02273d6950"} {"level":"info","ts":"2026-09-07T03:25:22.967869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T03:25:22.967953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became follower at term 0"} {"level":"info","ts":"2026-09-07T03:25:22.968052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e064f6438c9a029d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T03:25:22.968078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became follower at term 1"} {"level":"info","ts":"2026-09-07T03:25:22.968196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d switched to configuration voters=(16169319332149068445)"} {"level":"warn","ts":"2026-09-07T03:25:22.977268Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T03:25:22.979012Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T03:25:22.982946Z","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-07T03:25:22.985471Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e064f6438c9a029d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T03:25:22.985712Z","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-07T03:25:22.985771Z","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-07T03:25:22.985781Z","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-07T03:25:22.985874Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e064f6438c9a029d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T03:25:22.988216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d switched to configuration voters=(16169319332149068445)"} {"level":"info","ts":"2026-09-07T03:25:22.989661Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"46d59d02273d6950","local-member-id":"e064f6438c9a029d","added-peer-id":"e064f6438c9a029d","added-peer-peer-urls":["https://162.253.55.121:2380"]} {"level":"info","ts":"2026-09-07T03:25:22.99047Z","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-07T03:25:22.990647Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.121:2380"} {"level":"info","ts":"2026-09-07T03:25:22.990681Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.121:2380"} {"level":"info","ts":"2026-09-07T03:25:22.990848Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e064f6438c9a029d","initial-advertise-peer-urls":["https://162.253.55.121:2380"],"listen-peer-urls":["https://162.253.55.121:2380"],"advertise-client-urls":["https://162.253.55.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T03:25:22.990886Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T03:25:23.669981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T03:25:23.670063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T03:25:23.670111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d received MsgPreVoteResp from e064f6438c9a029d at term 1"} {"level":"info","ts":"2026-09-07T03:25:23.670139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became candidate at term 2"} {"level":"info","ts":"2026-09-07T03:25:23.670156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d received MsgVoteResp from e064f6438c9a029d at term 2"} {"level":"info","ts":"2026-09-07T03:25:23.670171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became leader at term 2"} {"level":"info","ts":"2026-09-07T03:25:23.67019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e064f6438c9a029d elected leader e064f6438c9a029d at term 2"} {"level":"info","ts":"2026-09-07T03:25:23.671484Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e064f6438c9a029d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.121:2379]}","request-path":"/0/members/e064f6438c9a029d/attributes","cluster-id":"46d59d02273d6950","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T03:25:23.671516Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T03:25:23.671654Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:25:23.671755Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T03:25:23.671633Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T03:25:23.671808Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T03:25:23.673477Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-07T03:25:23.674093Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.121:2379"} {"level":"info","ts":"2026-09-07T03:25:23.683Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"46d59d02273d6950","local-member-id":"e064f6438c9a029d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:25:23.683116Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:25:23.683155Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-09-07T03:25:57.958459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.59639ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:25:57.958725Z","caller":"traceutil/trace.go:171","msg":"trace[1843189920] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"175.913218ms","start":"2026-09-07T03:25:57.782774Z","end":"2026-09-07T03:25:57.958687Z","steps":["trace[1843189920] 'read index received' (duration: 52.470469ms)","trace[1843189920] 'applied index is now lower than readState.Index' (duration: 123.347406ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:25:57.959226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.456056ms","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-07T03:25:57.95938Z","caller":"traceutil/trace.go:171","msg":"trace[579530169] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:493; }","duration":"176.560539ms","start":"2026-09-07T03:25:57.782718Z","end":"2026-09-07T03:25:57.959278Z","steps":["trace[579530169] 'agreement among raft nodes before linearized reading' (duration: 176.233708ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:25:57.95936Z","caller":"traceutil/trace.go:171","msg":"trace[419799767] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"206.496967ms","start":"2026-09-07T03:25:57.752795Z","end":"2026-09-07T03:25:57.959292Z","steps":["trace[419799767] 'process raft request' (duration: 82.523331ms)","trace[419799767] 'compare' (duration: 121.472376ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:25:58.562235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.363854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:25:58.562388Z","caller":"traceutil/trace.go:171","msg":"trace[1217655718] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"596.503558ms","start":"2026-09-07T03:25:57.965823Z","end":"2026-09-07T03:25:58.562327Z","steps":["trace[1217655718] 'process raft request' (duration: 159.96418ms)","trace[1217655718] 'compare' (duration: 436.2635ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:25:58.562565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:25:57.965799Z","time spent":"596.662583ms","remote":"127.0.0.1:57070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T03:26:11.922636Z","caller":"traceutil/trace.go:171","msg":"trace[188208421] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"231.566298ms","start":"2026-09-07T03:26:11.691026Z","end":"2026-09-07T03:26:11.922592Z","steps":["trace[188208421] 'process raft request' (duration: 225.127988ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:26:12.541381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.752313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:26:12.541506Z","caller":"traceutil/trace.go:171","msg":"trace[799958050] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"581.452559ms","start":"2026-09-07T03:26:11.960033Z","end":"2026-09-07T03:26:12.541485Z","steps":["trace[799958050] 'process raft request' (duration: 344.483451ms)","trace[799958050] 'compare' (duration: 236.642579ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:26:12.541559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:26:11.959995Z","time spent":"581.541432ms","remote":"127.0.0.1:57070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T03:26:12.542367Z","caller":"traceutil/trace.go:171","msg":"trace[1886538116] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:674; }","duration":"508.723372ms","start":"2026-09-07T03:26:12.033619Z","end":"2026-09-07T03:26:12.542342Z","steps":["trace[1886538116] 'read index received' (duration: 270.91ms)","trace[1886538116] 'applied index is now lower than readState.Index' (duration: 237.811532ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:26:12.54247Z","caller":"traceutil/trace.go:171","msg":"trace[1171136732] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"555.805342ms","start":"2026-09-07T03:26:11.986646Z","end":"2026-09-07T03:26:12.542451Z","steps":["trace[1171136732] 'process raft request' (duration: 555.592496ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:26:12.542563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:26:11.986618Z","time spent":"555.886204ms","remote":"127.0.0.1:57030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T03:26:12.542816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.192595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-09-07T03:26:12.542845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.106713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-07T03:26:12.542868Z","caller":"traceutil/trace.go:171","msg":"trace[1775499207] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:655; }","duration":"382.169605ms","start":"2026-09-07T03:26:12.16069Z","end":"2026-09-07T03:26:12.542859Z","steps":["trace[1775499207] 'agreement among raft nodes before linearized reading' (duration: 382.100873ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:26:12.542887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:26:12.160666Z","time spent":"382.217455ms","remote":"127.0.0.1:57070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-07T03:26:12.542844Z","caller":"traceutil/trace.go:171","msg":"trace[1650405919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:655; }","duration":"509.277388ms","start":"2026-09-07T03:26:12.033557Z","end":"2026-09-07T03:26:12.542835Z","steps":["trace[1650405919] 'agreement among raft nodes before linearized reading' (duration: 509.102213ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:26:12.542977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:26:12.033531Z","time spent":"509.438852ms","remote":"127.0.0.1:57070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-07T03:26:28.898068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.444207ms","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-07T03:26:28.898167Z","caller":"traceutil/trace.go:171","msg":"trace[1804564138] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:816; }","duration":"127.600441ms","start":"2026-09-07T03:26:28.770545Z","end":"2026-09-07T03:26:28.898145Z","steps":["trace[1804564138] 'range keys from in-memory index tree' (duration: 127.288654ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:26:28.898146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.934213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-07T03:26:28.898241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.639001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-07T03:26:28.898256Z","caller":"traceutil/trace.go:171","msg":"trace[970377553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:816; }","duration":"259.097497ms","start":"2026-09-07T03:26:28.639133Z","end":"2026-09-07T03:26:28.898231Z","steps":["trace[970377553] 'range keys from in-memory index tree' (duration: 258.755098ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:26:28.898271Z","caller":"traceutil/trace.go:171","msg":"trace[1182185785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:816; }","duration":"269.660752ms","start":"2026-09-07T03:26:28.628598Z","end":"2026-09-07T03:26:28.898258Z","steps":["trace[1182185785] 'range keys from in-memory index tree' (duration: 269.544959ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:26:28.898146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.682614ms","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-07T03:26:28.898418Z","caller":"traceutil/trace.go:171","msg":"trace[1597941729] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:816; }","duration":"268.043962ms","start":"2026-09-07T03:26:28.630368Z","end":"2026-09-07T03:26:28.898412Z","steps":["trace[1597941729] 'range keys from in-memory index tree' (duration: 267.490279ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:26:48.799883Z","caller":"traceutil/trace.go:171","msg":"trace[928816717] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"100.466947ms","start":"2026-09-07T03:26:48.699385Z","end":"2026-09-07T03:26:48.799852Z","steps":["trace[928816717] 'process raft request' (duration: 99.989957ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:27:02.812703Z","caller":"traceutil/trace.go:171","msg":"trace[1510355096] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"499.00367ms","start":"2026-09-07T03:27:02.313671Z","end":"2026-09-07T03:27:02.812675Z","steps":["trace[1510355096] 'process raft request' (duration: 498.819376ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:27:02.812877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:27:02.313653Z","time spent":"499.134982ms","remote":"127.0.0.1:57070","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-07T03:27:57.067546Z","caller":"traceutil/trace.go:171","msg":"trace[305587747] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"221.352152ms","start":"2026-09-07T03:27:56.846156Z","end":"2026-09-07T03:27:57.067508Z","steps":["trace[305587747] 'process raft request' (duration: 220.896595ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:27:57.262017Z","caller":"traceutil/trace.go:171","msg":"trace[246049573] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"180.056355ms","start":"2026-09-07T03:27:57.081916Z","end":"2026-09-07T03:27:57.261973Z","steps":["trace[246049573] 'process raft request' (duration: 179.848122ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:27:57.47051Z","caller":"traceutil/trace.go:171","msg":"trace[651366194] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"200.869792ms","start":"2026-09-07T03:27:57.269609Z","end":"2026-09-07T03:27:57.470479Z","steps":["trace[651366194] 'process raft request' (duration: 200.559058ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:27:57.470871Z","caller":"traceutil/trace.go:171","msg":"trace[1978211032] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"201.119896ms","start":"2026-09-07T03:27:57.269726Z","end":"2026-09-07T03:27:57.470846Z","steps":["trace[1978211032] 'process raft request' (duration: 200.989274ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:27:57.471023Z","caller":"traceutil/trace.go:171","msg":"trace[859162410] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"201.320288ms","start":"2026-09-07T03:27:57.269696Z","end":"2026-09-07T03:27:57.471016Z","steps":["trace[859162410] 'process raft request' (duration: 200.696199ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:27:57.471092Z","caller":"traceutil/trace.go:171","msg":"trace[843510008] linearizableReadLoop","detail":"{readStateIndex:2000; appliedIndex:1995; }","duration":"192.818103ms","start":"2026-09-07T03:27:57.278267Z","end":"2026-09-07T03:27:57.471085Z","steps":["trace[843510008] 'read index received' (duration: 8.10195ms)","trace[843510008] 'applied index is now lower than readState.Index' (duration: 184.715403ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:27:57.471204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.938985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.121\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-07T03:27:57.471224Z","caller":"traceutil/trace.go:171","msg":"trace[1563336524] range","detail":"{range_begin:/registry/masterleases/162.253.55.121; range_end:; response_count:1; response_revision:1927; }","duration":"193.022426ms","start":"2026-09-07T03:27:57.278195Z","end":"2026-09-07T03:27:57.471218Z","steps":["trace[1563336524] 'agreement among raft nodes before linearized reading' (duration: 192.908115ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:27:57.471252Z","caller":"traceutil/trace.go:171","msg":"trace[982811572] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"201.37516ms","start":"2026-09-07T03:27:57.269866Z","end":"2026-09-07T03:27:57.471241Z","steps":["trace[982811572] 'process raft request' (duration: 200.940683ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:28:29.984713Z","caller":"traceutil/trace.go:171","msg":"trace[854812431] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"138.086208ms","start":"2026-09-07T03:28:29.846578Z","end":"2026-09-07T03:28:29.984664Z","steps":["trace[854812431] 'process raft request' (duration: 61.880757ms)","trace[854812431] 'compare' (duration: 75.747445ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:28:31.797873Z","caller":"traceutil/trace.go:171","msg":"trace[858660931] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"160.145228ms","start":"2026-09-07T03:28:31.637683Z","end":"2026-09-07T03:28:31.797828Z","steps":["trace[858660931] 'process raft request' (duration: 90.876185ms)","trace[858660931] 'compare' (duration: 68.721346ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:28:32.01228Z","caller":"traceutil/trace.go:171","msg":"trace[1971192984] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"209.138277ms","start":"2026-09-07T03:28:31.803096Z","end":"2026-09-07T03:28:32.012235Z","steps":["trace[1971192984] 'process raft request' (duration: 160.428922ms)","trace[1971192984] 'compare' (duration: 48.31761ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:28:32.012358Z","caller":"traceutil/trace.go:171","msg":"trace[1302451258] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2244; }","duration":"202.832503ms","start":"2026-09-07T03:28:31.809496Z","end":"2026-09-07T03:28:32.012329Z","steps":["trace[1302451258] 'read index received' (duration: 154.040766ms)","trace[1302451258] 'applied index is now lower than readState.Index' (duration: 48.790107ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:28:32.012602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.087466ms","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-07T03:28:32.012635Z","caller":"traceutil/trace.go:171","msg":"trace[1499081274] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2164; }","duration":"203.169967ms","start":"2026-09-07T03:28:31.809456Z","end":"2026-09-07T03:28:32.012626Z","steps":["trace[1499081274] 'agreement among raft nodes before linearized reading' (duration: 203.021885ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:28:32.012777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.988473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-07T03:28:32.012824Z","caller":"traceutil/trace.go:171","msg":"trace[1615093679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2164; }","duration":"191.079614ms","start":"2026-09-07T03:28:31.821733Z","end":"2026-09-07T03:28:32.012813Z","steps":["trace[1615093679] 'agreement among raft nodes before linearized reading' (duration: 190.902612ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:28:32.012885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.7944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-07T03:28:32.012852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.320744ms","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-07T03:28:32.012916Z","caller":"traceutil/trace.go:171","msg":"trace[404591368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2164; }","duration":"190.851631ms","start":"2026-09-07T03:28:31.822057Z","end":"2026-09-07T03:28:32.012909Z","steps":["trace[404591368] 'agreement among raft nodes before linearized reading' (duration: 190.77981ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:28:32.012973Z","caller":"traceutil/trace.go:171","msg":"trace[1491972285] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2164; }","duration":"190.459446ms","start":"2026-09-07T03:28:31.822473Z","end":"2026-09-07T03:28:32.012932Z","steps":["trace[1491972285] 'agreement among raft nodes before linearized reading' (duration: 190.232453ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:28:32.454959Z","caller":"traceutil/trace.go:171","msg":"trace[2033906335] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"163.488078ms","start":"2026-09-07T03:28:32.291378Z","end":"2026-09-07T03:28:32.454866Z","steps":["trace[2033906335] 'process raft request' (duration: 163.134753ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:28:32.850737Z","caller":"traceutil/trace.go:171","msg":"trace[553280450] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"190.139147ms","start":"2026-09-07T03:28:32.660561Z","end":"2026-09-07T03:28:32.850701Z","steps":["trace[553280450] 'process raft request' (duration: 189.953944ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:30:19.207531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.559858ms","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-07T03:30:19.207666Z","caller":"traceutil/trace.go:171","msg":"trace[477309093] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2850; }","duration":"105.777405ms","start":"2026-09-07T03:30:19.101863Z","end":"2026-09-07T03:30:19.20764Z","steps":["trace[477309093] 'range keys from in-memory index tree' (duration: 105.256867ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:35:02.477742Z","caller":"traceutil/trace.go:171","msg":"trace[1727187983] linearizableReadLoop","detail":"{readStateIndex:5036; appliedIndex:5035; }","duration":"187.806776ms","start":"2026-09-07T03:35:02.28987Z","end":"2026-09-07T03:35:02.477677Z","steps":["trace[1727187983] 'read index received' (duration: 159.173112ms)","trace[1727187983] 'applied index is now lower than readState.Index' (duration: 28.632254ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:35:02.47788Z","caller":"traceutil/trace.go:171","msg":"trace[1169882810] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"242.230894ms","start":"2026-09-07T03:35:02.235613Z","end":"2026-09-07T03:35:02.477844Z","steps":["trace[1169882810] 'process raft request' (duration: 213.571689ms)","trace[1169882810] 'compare' (duration: 28.092325ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:35:02.478073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.182832ms","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-07T03:35:02.478178Z","caller":"traceutil/trace.go:171","msg":"trace[707676180] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4851; }","duration":"188.339325ms","start":"2026-09-07T03:35:02.289809Z","end":"2026-09-07T03:35:02.478148Z","steps":["trace[707676180] 'agreement among raft nodes before linearized reading' (duration: 188.04759ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:35:02.478175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.132327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T03:35:02.478243Z","caller":"traceutil/trace.go:171","msg":"trace[584844083] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:4851; }","duration":"165.31113ms","start":"2026-09-07T03:35:02.312913Z","end":"2026-09-07T03:35:02.478224Z","steps":["trace[584844083] 'agreement among raft nodes before linearized reading' (duration: 165.177547ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:35:02.478286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.695691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-07T03:35:02.478343Z","caller":"traceutil/trace.go:171","msg":"trace[297018867] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4851; }","duration":"155.807663ms","start":"2026-09-07T03:35:02.322522Z","end":"2026-09-07T03:35:02.478329Z","steps":["trace[297018867] 'agreement among raft nodes before linearized reading' (duration: 155.65687ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:35:02.478975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.003243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-07T03:35:02.479083Z","caller":"traceutil/trace.go:171","msg":"trace[648242033] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4851; }","duration":"124.166705ms","start":"2026-09-07T03:35:02.354887Z","end":"2026-09-07T03:35:02.479053Z","steps":["trace[648242033] 'agreement among raft nodes before linearized reading' (duration: 123.929181ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:35:16.416611Z","caller":"traceutil/trace.go:171","msg":"trace[707253134] transaction","detail":"{read_only:false; response_revision:5161; number_of_response:1; }","duration":"122.002419ms","start":"2026-09-07T03:35:16.294567Z","end":"2026-09-07T03:35:16.416569Z","steps":["trace[707253134] 'process raft request' (duration: 105.90912ms)","trace[707253134] 'compare' (duration: 15.947427ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:35:16.676654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.622494ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:35:16.677034Z","caller":"traceutil/trace.go:171","msg":"trace[1249609764] transaction","detail":"{read_only:false; response_revision:5163; number_of_response:1; }","duration":"167.375708ms","start":"2026-09-07T03:35:16.509627Z","end":"2026-09-07T03:35:16.677003Z","steps":["trace[1249609764] 'process raft request' (duration: 167.172534ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:35:16.677154Z","caller":"traceutil/trace.go:171","msg":"trace[1454080781] linearizableReadLoop","detail":"{readStateIndex:5353; appliedIndex:5352; }","duration":"171.061292ms","start":"2026-09-07T03:35:16.506073Z","end":"2026-09-07T03:35:16.677134Z","steps":["trace[1454080781] 'read index received' (duration: 37.936399ms)","trace[1454080781] 'applied index is now lower than readState.Index' (duration: 133.122723ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:35:16.67745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.563954ms","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-07T03:35:16.677503Z","caller":"traceutil/trace.go:171","msg":"trace[1069605577] 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:5163; }","duration":"158.694087ms","start":"2026-09-07T03:35:16.518794Z","end":"2026-09-07T03:35:16.677488Z","steps":["trace[1069605577] 'agreement among raft nodes before linearized reading' (duration: 158.499834ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:35:16.677555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.336808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-07T03:35:16.67773Z","caller":"traceutil/trace.go:171","msg":"trace[1318451169] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5163; }","duration":"106.543501ms","start":"2026-09-07T03:35:16.571163Z","end":"2026-09-07T03:35:16.677707Z","steps":["trace[1318451169] 'agreement among raft nodes before linearized reading' (duration: 106.202645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:35:16.677783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.319133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T03:35:16.677837Z","caller":"traceutil/trace.go:171","msg":"trace[931409363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5163; }","duration":"115.406685ms","start":"2026-09-07T03:35:16.56242Z","end":"2026-09-07T03:35:16.677827Z","steps":["trace[931409363] 'agreement among raft nodes before linearized reading' (duration: 115.332844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:35:16.677903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.807845ms","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":"warn","ts":"2026-09-07T03:35:16.677949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.062935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-07T03:35:16.67795Z","caller":"traceutil/trace.go:171","msg":"trace[525163820] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5163; }","duration":"171.922567ms","start":"2026-09-07T03:35:16.506014Z","end":"2026-09-07T03:35:16.677936Z","steps":["trace[525163820] 'agreement among raft nodes before linearized reading' (duration: 171.213734ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:35:16.677995Z","caller":"traceutil/trace.go:171","msg":"trace[1824897854] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5163; }","duration":"105.124537ms","start":"2026-09-07T03:35:16.572855Z","end":"2026-09-07T03:35:16.67798Z","steps":["trace[1824897854] 'agreement among raft nodes before linearized reading' (duration: 105.015805ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:35:16.678006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.895497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T03:35:16.678038Z","caller":"traceutil/trace.go:171","msg":"trace[1725699732] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5163; }","duration":"144.973898ms","start":"2026-09-07T03:35:16.533054Z","end":"2026-09-07T03:35:16.678028Z","steps":["trace[1725699732] 'agreement among raft nodes before linearized reading' (duration: 144.916077ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:35:16.677075Z","caller":"traceutil/trace.go:171","msg":"trace[2017548647] transaction","detail":"{read_only:false; response_revision:5162; number_of_response:1; }","duration":"178.944799ms","start":"2026-09-07T03:35:16.498052Z","end":"2026-09-07T03:35:16.676997Z","steps":["trace[2017548647] 'process raft request' (duration: 45.860947ms)","trace[2017548647] 'compare' (duration: 131.472034ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:35:16.948444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.066497ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:35:16.948728Z","caller":"traceutil/trace.go:171","msg":"trace[1874158758] linearizableReadLoop","detail":"{readStateIndex:5366; appliedIndex:5365; }","duration":"189.038424ms","start":"2026-09-07T03:35:16.759649Z","end":"2026-09-07T03:35:16.948687Z","steps":["trace[1874158758] 'read index received' (duration: 26.51728ms)","trace[1874158758] 'applied index is now lower than readState.Index' (duration: 162.514544ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:35:16.949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.30701ms","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-07T03:35:16.949094Z","caller":"traceutil/trace.go:171","msg":"trace[1319665857] 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:5175; }","duration":"189.436812ms","start":"2026-09-07T03:35:16.759628Z","end":"2026-09-07T03:35:16.949065Z","steps":["trace[1319665857] 'agreement among raft nodes before linearized reading' (duration: 189.118286ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:35:16.949148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.304131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-09-07T03:35:16.949218Z","caller":"traceutil/trace.go:171","msg":"trace[910931537] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5176; }","duration":"181.395822ms","start":"2026-09-07T03:35:16.767797Z","end":"2026-09-07T03:35:16.949193Z","steps":["trace[910931537] 'agreement among raft nodes before linearized reading' (duration: 181.179838ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:35:16.949238Z","caller":"traceutil/trace.go:171","msg":"trace[1799475530] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"160.951947ms","start":"2026-09-07T03:35:16.788246Z","end":"2026-09-07T03:35:16.949198Z","steps":["trace[1799475530] 'process raft request' (duration: 160.323726ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:35:16.94889Z","caller":"traceutil/trace.go:171","msg":"trace[286990676] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"206.720532ms","start":"2026-09-07T03:35:16.741938Z","end":"2026-09-07T03:35:16.948658Z","steps":["trace[286990676] 'process raft request' (duration: 44.31225ms)","trace[286990676] 'compare' (duration: 161.906263ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:35:17.095276Z","caller":"traceutil/trace.go:171","msg":"trace[1817251184] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"139.200597ms","start":"2026-09-07T03:35:16.956038Z","end":"2026-09-07T03:35:17.095239Z","steps":["trace[1817251184] 'process raft request' (duration: 113.43184ms)","trace[1817251184] 'compare' (duration: 25.593704ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:35:17.110083Z","caller":"traceutil/trace.go:171","msg":"trace[729786285] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"149.202471ms","start":"2026-09-07T03:35:16.96086Z","end":"2026-09-07T03:35:17.110062Z","steps":["trace[729786285] 'process raft request' (duration: 148.487678ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:35:17.110095Z","caller":"traceutil/trace.go:171","msg":"trace[2102296811] transaction","detail":"{read_only:false; response_revision:5179; number_of_response:1; }","duration":"149.044518ms","start":"2026-09-07T03:35:16.961Z","end":"2026-09-07T03:35:17.110044Z","steps":["trace[2102296811] 'process raft request' (duration: 148.56212ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:35:17.109916Z","caller":"traceutil/trace.go:171","msg":"trace[857760178] transaction","detail":"{read_only:false; response_revision:5180; number_of_response:1; }","duration":"146.29547ms","start":"2026-09-07T03:35:16.963569Z","end":"2026-09-07T03:35:17.109864Z","steps":["trace[857760178] 'process raft request' (duration: 146.075046ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:35:23.716194Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2872} {"level":"info","ts":"2026-09-07T03:35:23.805698Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2872,"took":"88.599561ms","hash":222025853,"current-db-size-bytes":51613696,"current-db-size":"52 MB","current-db-size-in-use-bytes":27213824,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-07T03:35:23.805788Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":222025853,"revision":2872,"compact-revision":-1} {"level":"info","ts":"2026-09-07T03:35:29.783266Z","caller":"traceutil/trace.go:171","msg":"trace[504019561] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"104.784751ms","start":"2026-09-07T03:35:29.678446Z","end":"2026-09-07T03:35:29.783231Z","steps":["trace[504019561] 'process raft request' (duration: 104.325773ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:40:23.722132Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5291} {"level":"info","ts":"2026-09-07T03:40:23.797193Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5291,"took":"73.260984ms","hash":3388842570,"current-db-size-bytes":51613696,"current-db-size":"52 MB","current-db-size-in-use-bytes":19312640,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-07T03:40:23.797269Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3388842570,"revision":5291,"compact-revision":2872}