{"level":"warn","ts":"2026-09-02T01:10:22.780486Z","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-02T01:10:22.780581Z","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-02T01:10:22.780661Z","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-02T01:10:22.780677Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-09-02T01:10:22.780703Z","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-02T01:10:22.781407Z","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-02T01:10:22.781492Z","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-02T01:10:22.800126Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"18.382161ms"} {"level":"info","ts":"2026-09-02T01:10:22.847087Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a0f50f8a6c5f7d06","cluster-id":"62f129f77cf8e487"} {"level":"info","ts":"2026-09-02T01:10:22.847281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=()"} {"level":"info","ts":"2026-09-02T01:10:22.847318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 0"} {"level":"info","ts":"2026-09-02T01:10:22.847379Z","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-02T01:10:22.847396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 1"} {"level":"info","ts":"2026-09-02T01:10:22.847482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"warn","ts":"2026-09-02T01:10:22.861491Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-02T01:10:22.862991Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-02T01:10:22.864154Z","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-02T01:10:22.866077Z","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-02T01:10:22.866277Z","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-02T01:10:22.866439Z","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-02T01:10:22.86653Z","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-02T01:10:22.86654Z","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-02T01:10:22.871712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"info","ts":"2026-09-02T01:10:22.872753Z","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-02T01:10:22.873772Z","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-02T01:10:22.874016Z","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-02T01:10:22.874041Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-02T01:10:22.874503Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-09-02T01:10:22.874526Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-09-02T01:10:23.548123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 is starting a new election at term 1"} {"level":"info","ts":"2026-09-02T01:10:23.548212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-02T01:10:23.548242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgPreVoteResp from a0f50f8a6c5f7d06 at term 1"} {"level":"info","ts":"2026-09-02T01:10:23.548266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became candidate at term 2"} {"level":"info","ts":"2026-09-02T01:10:23.548288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgVoteResp from a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-09-02T01:10:23.548314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became leader at term 2"} {"level":"info","ts":"2026-09-02T01:10:23.548357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a0f50f8a6c5f7d06 elected leader a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-09-02T01:10:23.549842Z","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-02T01:10:23.549834Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T01:10:23.550048Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T01:10:23.550036Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T01:10:23.550203Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-02T01:10:23.550242Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-02T01:10:23.551869Z","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-02T01:10:23.552112Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T01:10:23.552194Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T01:10:23.554709Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.223:2379"} {"level":"info","ts":"2026-09-02T01:10:23.555508Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-02T01:10:42.980499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.675164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:10:42.980658Z","caller":"traceutil/trace.go:171","msg":"trace[19054375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:378; }","duration":"199.831934ms","start":"2026-09-02T01:10:42.780785Z","end":"2026-09-02T01:10:42.980617Z","steps":["trace[19054375] 'range keys from in-memory index tree' (duration: 199.622533ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:11:01.670614Z","caller":"traceutil/trace.go:171","msg":"trace[1582665898] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"131.959101ms","start":"2026-09-02T01:11:01.538608Z","end":"2026-09-02T01:11:01.670567Z","steps":["trace[1582665898] 'process raft request' (duration: 115.774494ms)","trace[1582665898] 'compare' (duration: 16.020246ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:11:01.671538Z","caller":"traceutil/trace.go:171","msg":"trace[1622303426] transaction","detail":"{read_only:false; number_of_response:1; response_revision:537; }","duration":"122.046208ms","start":"2026-09-02T01:11:01.54947Z","end":"2026-09-02T01:11:01.671516Z","steps":["trace[1622303426] 'process raft request' (duration: 121.549365ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:11:07.458146Z","caller":"traceutil/trace.go:171","msg":"trace[1987857623] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"164.321568ms","start":"2026-09-02T01:11:07.293758Z","end":"2026-09-02T01:11:07.458079Z","steps":["trace[1987857623] 'process raft request' (duration: 154.989287ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:11:07.746088Z","caller":"traceutil/trace.go:171","msg":"trace[1252842925] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:605; }","duration":"165.347654ms","start":"2026-09-02T01:11:07.580718Z","end":"2026-09-02T01:11:07.746065Z","steps":["trace[1252842925] 'read index received' (duration: 73.094369ms)","trace[1252842925] 'applied index is now lower than readState.Index' (duration: 92.252195ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:11:07.74621Z","caller":"traceutil/trace.go:171","msg":"trace[1715100285] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"278.595463ms","start":"2026-09-02T01:11:07.467596Z","end":"2026-09-02T01:11:07.746192Z","steps":["trace[1715100285] 'process raft request' (duration: 186.171428ms)","trace[1715100285] 'compare' (duration: 92.037173ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:11:07.746377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.645625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-t2srp\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-02T01:11:07.746408Z","caller":"traceutil/trace.go:171","msg":"trace[1687010974] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"228.619829ms","start":"2026-09-02T01:11:07.517779Z","end":"2026-09-02T01:11:07.746399Z","steps":["trace[1687010974] 'process raft request' (duration: 228.200007ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:11:07.746453Z","caller":"traceutil/trace.go:171","msg":"trace[1616321834] range","detail":"{range_begin:/registry/pods/kube-system/cilium-t2srp; range_end:; response_count:1; response_revision:584; }","duration":"165.765155ms","start":"2026-09-02T01:11:07.580666Z","end":"2026-09-02T01:11:07.746431Z","steps":["trace[1616321834] 'agreement among raft nodes before linearized reading' (duration: 165.603975ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:11:08.235055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:11:07.905263Z","time spent":"329.784323ms","remote":"127.0.0.1:54702","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-09-02T01:11:08.235128Z","caller":"traceutil/trace.go:171","msg":"trace[902243592] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"438.723029ms","start":"2026-09-02T01:11:07.796386Z","end":"2026-09-02T01:11:08.235109Z","steps":["trace[902243592] 'read index received' (duration: 368.967427ms)","trace[902243592] 'applied index is now lower than readState.Index' (duration: 69.754792ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:11:08.235314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.91518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T01:11:08.235337Z","caller":"traceutil/trace.go:171","msg":"trace[796786127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"438.97502ms","start":"2026-09-02T01:11:07.796355Z","end":"2026-09-02T01:11:08.23533Z","steps":["trace[796786127] 'agreement among raft nodes before linearized reading' (duration: 438.92711ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:11:08.235356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:11:07.796341Z","time spent":"439.01047ms","remote":"127.0.0.1:54960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-02T01:11:08.235272Z","caller":"traceutil/trace.go:171","msg":"trace[417631353] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"454.724947ms","start":"2026-09-02T01:11:07.780484Z","end":"2026-09-02T01:11:08.235209Z","steps":["trace[417631353] 'process raft request' (duration: 384.857315ms)","trace[417631353] 'compare' (duration: 69.579691ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:11:08.236733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:11:07.780461Z","time spent":"455.581462ms","remote":"127.0.0.1:55144","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-02T01:11:09.858045Z","caller":"traceutil/trace.go:171","msg":"trace[717215690] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"127.283285ms","start":"2026-09-02T01:11:09.730734Z","end":"2026-09-02T01:11:09.858017Z","steps":["trace[717215690] 'process raft request' (duration: 127.028374ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:11:09.858279Z","caller":"traceutil/trace.go:171","msg":"trace[449938852] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:637; }","duration":"108.04328ms","start":"2026-09-02T01:11:09.75022Z","end":"2026-09-02T01:11:09.858264Z","steps":["trace[449938852] 'read index received' (duration: 536.743µs)","trace[449938852] 'applied index is now lower than readState.Index' (duration: 107.505767ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:11:09.858456Z","caller":"traceutil/trace.go:171","msg":"trace[1857836203] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"126.504762ms","start":"2026-09-02T01:11:09.731939Z","end":"2026-09-02T01:11:09.858444Z","steps":["trace[1857836203] 'process raft request' (duration: 125.989349ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:11:09.858679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.440242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-02T01:11:09.858717Z","caller":"traceutil/trace.go:171","msg":"trace[1173882449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"108.511932ms","start":"2026-09-02T01:11:09.750195Z","end":"2026-09-02T01:11:09.858707Z","steps":["trace[1173882449] 'agreement among raft nodes before linearized reading' (duration: 108.356511ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:11:54.119825Z","caller":"traceutil/trace.go:171","msg":"trace[21191810] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"167.800837ms","start":"2026-09-02T01:11:53.951996Z","end":"2026-09-02T01:11:54.119797Z","steps":["trace[21191810] 'process raft request' (duration: 167.561536ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:26.442053Z","caller":"traceutil/trace.go:171","msg":"trace[416652256] linearizableReadLoop","detail":"{readStateIndex:1664; appliedIndex:1662; }","duration":"119.226011ms","start":"2026-09-02T01:12:26.322783Z","end":"2026-09-02T01:12:26.442009Z","steps":["trace[416652256] 'read index received' (duration: 92.036952ms)","trace[416652256] 'applied index is now lower than readState.Index' (duration: 27.188079ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:12:26.442119Z","caller":"traceutil/trace.go:171","msg":"trace[1625788707] transaction","detail":"{read_only:false; response_revision:1602; number_of_response:1; }","duration":"146.27244ms","start":"2026-09-02T01:12:26.295803Z","end":"2026-09-02T01:12:26.442076Z","steps":["trace[1625788707] 'process raft request' (duration: 119.085401ms)","trace[1625788707] 'compare' (duration: 26.918306ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:12:26.442169Z","caller":"traceutil/trace.go:171","msg":"trace[405409694] transaction","detail":"{read_only:false; response_revision:1603; number_of_response:1; }","duration":"139.250541ms","start":"2026-09-02T01:12:26.302905Z","end":"2026-09-02T01:12:26.442155Z","steps":["trace[405409694] 'process raft request' (duration: 139.050049ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:26.442719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.345233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/rabbitmq-cluster-operator\" ","response":"range_response_count:1 size:1080"} {"level":"info","ts":"2026-09-02T01:12:26.442791Z","caller":"traceutil/trace.go:171","msg":"trace[1314083432] range","detail":"{range_begin:/registry/serviceaccounts/openstack/rabbitmq-cluster-operator; range_end:; response_count:1; response_revision:1603; }","duration":"163.463313ms","start":"2026-09-02T01:12:26.279308Z","end":"2026-09-02T01:12:26.442771Z","steps":["trace[1314083432] 'agreement among raft nodes before linearized reading' (duration: 163.301002ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:41.614359Z","caller":"traceutil/trace.go:171","msg":"trace[926202969] linearizableReadLoop","detail":"{readStateIndex:1896; appliedIndex:1895; }","duration":"225.036779ms","start":"2026-09-02T01:12:41.389299Z","end":"2026-09-02T01:12:41.614336Z","steps":["trace[926202969] 'read index received' (duration: 224.915118ms)","trace[926202969] 'applied index is now lower than readState.Index' (duration: 120.661µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:12:41.614476Z","caller":"traceutil/trace.go:171","msg":"trace[270862607] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"343.325545ms","start":"2026-09-02T01:12:41.271124Z","end":"2026-09-02T01:12:41.614449Z","steps":["trace[270862607] 'process raft request' (duration: 343.075713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:41.614545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.22851ms","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-02T01:12:41.614574Z","caller":"traceutil/trace.go:171","msg":"trace[108148985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1825; }","duration":"225.29956ms","start":"2026-09-02T01:12:41.389266Z","end":"2026-09-02T01:12:41.614565Z","steps":["trace[108148985] 'agreement among raft nodes before linearized reading' (duration: 225.157599ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:41.614615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T01:12:41.271102Z","time spent":"343.434655ms","remote":"127.0.0.1:55242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T01:12:42.177845Z","caller":"traceutil/trace.go:171","msg":"trace[582805304] linearizableReadLoop","detail":"{readStateIndex:1899; appliedIndex:1898; }","duration":"116.544697ms","start":"2026-09-02T01:12:42.061273Z","end":"2026-09-02T01:12:42.177817Z","steps":["trace[582805304] 'read index received' (duration: 76.79129ms)","trace[582805304] 'applied index is now lower than readState.Index' (duration: 39.751907ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:12:42.178236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.941879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ac149f4b-b73f-4b37-9f59-a39353c8892a\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-02T01:12:42.17832Z","caller":"traceutil/trace.go:171","msg":"trace[771491226] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ac149f4b-b73f-4b37-9f59-a39353c8892a; range_end:; response_count:1; response_revision:1827; }","duration":"117.069439ms","start":"2026-09-02T01:12:42.061231Z","end":"2026-09-02T01:12:42.178301Z","steps":["trace[771491226] 'agreement among raft nodes before linearized reading' (duration: 116.670147ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:56.844535Z","caller":"traceutil/trace.go:171","msg":"trace[416562458] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"181.981354ms","start":"2026-09-02T01:12:56.662531Z","end":"2026-09-02T01:12:56.844513Z","steps":["trace[416562458] 'process raft request' (duration: 181.783913ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:56.844867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.056274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-02T01:12:56.844949Z","caller":"traceutil/trace.go:171","msg":"trace[11249371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1947; }","duration":"173.145795ms","start":"2026-09-02T01:12:56.671782Z","end":"2026-09-02T01:12:56.844928Z","steps":["trace[11249371] 'agreement among raft nodes before linearized reading' (duration: 172.911223ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:12:56.845023Z","caller":"traceutil/trace.go:171","msg":"trace[518987332] linearizableReadLoop","detail":"{readStateIndex:2021; appliedIndex:2020; }","duration":"172.677581ms","start":"2026-09-02T01:12:56.671788Z","end":"2026-09-02T01:12:56.844466Z","steps":["trace[518987332] 'read index received' (duration: 172.499631ms)","trace[518987332] 'applied index is now lower than readState.Index' (duration: 176.98µs)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:12:56.845238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.497442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-67fdb85b4f-d5rx5\" ","response":"range_response_count:1 size:5861"} {"level":"info","ts":"2026-09-02T01:12:56.845309Z","caller":"traceutil/trace.go:171","msg":"trace[2060476943] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-67fdb85b4f-d5rx5; range_end:; response_count:1; response_revision:1947; }","duration":"172.622193ms","start":"2026-09-02T01:12:56.672671Z","end":"2026-09-02T01:12:56.845294Z","steps":["trace[2060476943] 'agreement among raft nodes before linearized reading' (duration: 172.422092ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:12:56.845353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.625559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-02T01:12:56.845397Z","caller":"traceutil/trace.go:171","msg":"trace[9956806] range","detail":"{range_begin:/registry/masterleases/162.253.55.223; range_end:; response_count:1; response_revision:1947; }","duration":"142.669939ms","start":"2026-09-02T01:12:56.702714Z","end":"2026-09-02T01:12:56.845384Z","steps":["trace[9956806] 'agreement among raft nodes before linearized reading' (duration: 142.522008ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:13:16.825071Z","caller":"traceutil/trace.go:171","msg":"trace[644875309] linearizableReadLoop","detail":"{readStateIndex:2150; appliedIndex:2149; }","duration":"120.605358ms","start":"2026-09-02T01:13:16.704444Z","end":"2026-09-02T01:13:16.82505Z","steps":["trace[644875309] 'read index received' (duration: 120.426487ms)","trace[644875309] 'applied index is now lower than readState.Index' (duration: 178.291µs)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:13:16.825304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.818899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.223\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-09-02T01:13:16.825346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.536501ms","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-02T01:13:16.825376Z","caller":"traceutil/trace.go:171","msg":"trace[32918865] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2072; }","duration":"104.628081ms","start":"2026-09-02T01:13:16.720741Z","end":"2026-09-02T01:13:16.82537Z","steps":["trace[32918865] 'agreement among raft nodes before linearized reading' (duration: 104.53886ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:13:16.825373Z","caller":"traceutil/trace.go:171","msg":"trace[1337604049] range","detail":"{range_begin:/registry/masterleases/162.253.55.223; range_end:; response_count:1; response_revision:2072; }","duration":"120.92855ms","start":"2026-09-02T01:13:16.704422Z","end":"2026-09-02T01:13:16.82535Z","steps":["trace[1337604049] 'agreement among raft nodes before linearized reading' (duration: 120.733489ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:13:16.825395Z","caller":"traceutil/trace.go:171","msg":"trace[1297366386] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"124.339569ms","start":"2026-09-02T01:13:16.701037Z","end":"2026-09-02T01:13:16.825376Z","steps":["trace[1297366386] 'process raft request' (duration: 123.875817ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:13:17.225338Z","caller":"traceutil/trace.go:171","msg":"trace[984971775] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"214.044619ms","start":"2026-09-02T01:13:17.011269Z","end":"2026-09-02T01:13:17.225313Z","steps":["trace[984971775] 'process raft request' (duration: 116.048204ms)","trace[984971775] 'compare' (duration: 97.725643ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:13:17.22565Z","caller":"traceutil/trace.go:171","msg":"trace[1307477120] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"154.601843ms","start":"2026-09-02T01:13:17.071038Z","end":"2026-09-02T01:13:17.22564Z","steps":["trace[1307477120] 'process raft request' (duration: 154.221471ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:13:18.072466Z","caller":"traceutil/trace.go:171","msg":"trace[1631866656] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"218.723864ms","start":"2026-09-02T01:13:17.853697Z","end":"2026-09-02T01:13:18.072421Z","steps":["trace[1631866656] 'process raft request' (duration: 139.705463ms)","trace[1631866656] 'compare' (duration: 78.82963ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:14:53.81456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.791693ms","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-02T01:14:53.814649Z","caller":"traceutil/trace.go:171","msg":"trace[213212006] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2699; }","duration":"104.957003ms","start":"2026-09-02T01:14:53.709673Z","end":"2026-09-02T01:14:53.81463Z","steps":["trace[213212006] 'range keys from in-memory index tree' (duration: 104.550611ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:14:53.81456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.580949ms","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-02T01:14:53.814766Z","caller":"traceutil/trace.go:171","msg":"trace[1230215913] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2699; }","duration":"122.831441ms","start":"2026-09-02T01:14:53.691915Z","end":"2026-09-02T01:14:53.814747Z","steps":["trace[1230215913] 'range keys from in-memory index tree' (duration: 122.389838ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:19:38.14446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.028557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-09-02T01:19:38.144532Z","caller":"traceutil/trace.go:171","msg":"trace[93528814] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4839; }","duration":"124.129607ms","start":"2026-09-02T01:19:38.020385Z","end":"2026-09-02T01:19:38.144515Z","steps":["trace[93528814] 'range keys from in-memory index tree' (duration: 123.878156ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:19:38.144544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.994029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fe738f91-8f9c-4106-9471-32b75cf838d5\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-09-02T01:19:38.144682Z","caller":"traceutil/trace.go:171","msg":"trace[903504493] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fe738f91-8f9c-4106-9471-32b75cf838d5; range_end:; response_count:1; response_revision:4839; }","duration":"106.16309ms","start":"2026-09-02T01:19:38.03849Z","end":"2026-09-02T01:19:38.144654Z","steps":["trace[903504493] 'range keys from in-memory index tree' (duration: 105.823248ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:38.146032Z","caller":"traceutil/trace.go:171","msg":"trace[166765852] linearizableReadLoop","detail":"{readStateIndex:5027; appliedIndex:5026; }","duration":"103.776897ms","start":"2026-09-02T01:19:38.042235Z","end":"2026-09-02T01:19:38.146012Z","steps":["trace[166765852] 'read index received' (duration: 103.637386ms)","trace[166765852] 'applied index is now lower than readState.Index' (duration: 138.291µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:19:38.146166Z","caller":"traceutil/trace.go:171","msg":"trace[1390851708] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"105.193515ms","start":"2026-09-02T01:19:38.04096Z","end":"2026-09-02T01:19:38.146154Z","steps":["trace[1390851708] 'process raft request' (duration: 104.936313ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:19:38.146177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.929288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-rzmf9.18d15c44aa59c79a\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-09-02T01:19:38.146203Z","caller":"traceutil/trace.go:171","msg":"trace[2124315265] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-rzmf9.18d15c44aa59c79a; range_end:; response_count:1; response_revision:4840; }","duration":"103.975108ms","start":"2026-09-02T01:19:38.042219Z","end":"2026-09-02T01:19:38.146194Z","steps":["trace[2124315265] 'agreement among raft nodes before linearized reading' (duration: 103.861757ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:44.381125Z","caller":"traceutil/trace.go:171","msg":"trace[313792947] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"121.151711ms","start":"2026-09-02T01:19:44.259952Z","end":"2026-09-02T01:19:44.381104Z","steps":["trace[313792947] 'process raft request' (duration: 31.599042ms)","trace[313792947] 'compare' (duration: 89.089046ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:19:44.54766Z","caller":"traceutil/trace.go:171","msg":"trace[477271583] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"105.227655ms","start":"2026-09-02T01:19:44.4424Z","end":"2026-09-02T01:19:44.547627Z","steps":["trace[477271583] 'process raft request' (duration: 74.686118ms)","trace[477271583] 'compare' (duration: 30.156926ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:19:44.766106Z","caller":"traceutil/trace.go:171","msg":"trace[1740730782] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"132.884206ms","start":"2026-09-02T01:19:44.633194Z","end":"2026-09-02T01:19:44.766079Z","steps":["trace[1740730782] 'process raft request' (duration: 115.780382ms)","trace[1740730782] 'compare' (duration: 16.624721ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:19:47.333683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.369276ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T01:19:47.3339Z","caller":"traceutil/trace.go:171","msg":"trace[293717878] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"145.539314ms","start":"2026-09-02T01:19:47.188337Z","end":"2026-09-02T01:19:47.333876Z","steps":["trace[293717878] 'process raft request' (duration: 26.642985ms)","trace[293717878] 'compare' (duration: 118.164605ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:19:47.333965Z","caller":"traceutil/trace.go:171","msg":"trace[1060926021] linearizableReadLoop","detail":"{readStateIndex:5219; appliedIndex:5218; }","duration":"138.196114ms","start":"2026-09-02T01:19:47.195741Z","end":"2026-09-02T01:19:47.333937Z","steps":["trace[1060926021] 'read index received' (duration: 19.186835ms)","trace[1060926021] 'applied index is now lower than readState.Index' (duration: 119.006829ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:19:47.334213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.458497ms","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-02T01:19:47.334271Z","caller":"traceutil/trace.go:171","msg":"trace[1959670156] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5029; }","duration":"138.546967ms","start":"2026-09-02T01:19:47.19571Z","end":"2026-09-02T01:19:47.334257Z","steps":["trace[1959670156] 'agreement among raft nodes before linearized reading' (duration: 138.341966ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:50.767681Z","caller":"traceutil/trace.go:171","msg":"trace[159086361] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"110.568533ms","start":"2026-09-02T01:19:50.65709Z","end":"2026-09-02T01:19:50.767658Z","steps":["trace[159086361] 'process raft request' (duration: 35.864236ms)","trace[159086361] 'compare' (duration: 74.479436ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:19:50.78849Z","caller":"traceutil/trace.go:171","msg":"trace[647117289] linearizableReadLoop","detail":"{readStateIndex:5280; appliedIndex:5278; }","duration":"125.255355ms","start":"2026-09-02T01:19:50.663221Z","end":"2026-09-02T01:19:50.788477Z","steps":["trace[647117289] 'read index received' (duration: 29.741373ms)","trace[647117289] 'applied index is now lower than readState.Index' (duration: 95.513282ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:19:50.788528Z","caller":"traceutil/trace.go:171","msg":"trace[1666727007] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"125.233214ms","start":"2026-09-02T01:19:50.663272Z","end":"2026-09-02T01:19:50.788505Z","steps":["trace[1666727007] 'process raft request' (duration: 125.139123ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:50.788728Z","caller":"traceutil/trace.go:171","msg":"trace[2076472053] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"121.598865ms","start":"2026-09-02T01:19:50.667122Z","end":"2026-09-02T01:19:50.788721Z","steps":["trace[2076472053] 'process raft request' (duration: 121.314863ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:50.788734Z","caller":"traceutil/trace.go:171","msg":"trace[430612832] transaction","detail":"{read_only:false; response_revision:5089; number_of_response:1; }","duration":"128.506522ms","start":"2026-09-02T01:19:50.660197Z","end":"2026-09-02T01:19:50.788704Z","steps":["trace[430612832] 'process raft request' (duration: 128.13686ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:19:50.788961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.727607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61699"} {"level":"info","ts":"2026-09-02T01:19:50.790525Z","caller":"traceutil/trace.go:171","msg":"trace[941145755] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5091; }","duration":"127.290745ms","start":"2026-09-02T01:19:50.663219Z","end":"2026-09-02T01:19:50.79051Z","steps":["trace[941145755] 'agreement among raft nodes before linearized reading' (duration: 125.648487ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:57.069461Z","caller":"traceutil/trace.go:171","msg":"trace[1599707553] transaction","detail":"{read_only:false; response_revision:5155; number_of_response:1; }","duration":"255.524945ms","start":"2026-09-02T01:19:56.813908Z","end":"2026-09-02T01:19:57.069433Z","steps":["trace[1599707553] 'process raft request' (duration: 250.310656ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:57.084706Z","caller":"traceutil/trace.go:171","msg":"trace[1311385397] linearizableReadLoop","detail":"{readStateIndex:5351; appliedIndex:5349; }","duration":"169.932527ms","start":"2026-09-02T01:19:56.914747Z","end":"2026-09-02T01:19:57.084679Z","steps":["trace[1311385397] 'read index received' (duration: 149.584576ms)","trace[1311385397] 'applied index is now lower than readState.Index' (duration: 20.346571ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T01:19:57.084874Z","caller":"traceutil/trace.go:171","msg":"trace[419889504] transaction","detail":"{read_only:false; response_revision:5156; number_of_response:1; }","duration":"265.240657ms","start":"2026-09-02T01:19:56.819618Z","end":"2026-09-02T01:19:57.084858Z","steps":["trace[419889504] 'process raft request' (duration: 264.894145ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:19:57.085086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.328659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-09-02T01:19:57.08512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.260778ms","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-02T01:19:57.085184Z","caller":"traceutil/trace.go:171","msg":"trace[887459910] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5156; }","duration":"170.4814ms","start":"2026-09-02T01:19:56.914685Z","end":"2026-09-02T01:19:57.085166Z","steps":["trace[887459910] 'agreement among raft nodes before linearized reading' (duration: 170.253049ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:57.08527Z","caller":"traceutil/trace.go:171","msg":"trace[2081752672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5156; }","duration":"135.361469ms","start":"2026-09-02T01:19:56.949822Z","end":"2026-09-02T01:19:57.085184Z","steps":["trace[2081752672] 'agreement among raft nodes before linearized reading' (duration: 135.169688ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:19:57.085409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.356371ms","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-02T01:19:57.085467Z","caller":"traceutil/trace.go:171","msg":"trace[1959547414] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5156; }","duration":"130.441883ms","start":"2026-09-02T01:19:56.955011Z","end":"2026-09-02T01:19:57.085452Z","steps":["trace[1959547414] 'agreement among raft nodes before linearized reading' (duration: 130.294941ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T01:19:57.480712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.96663ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T01:19:57.48143Z","caller":"traceutil/trace.go:171","msg":"trace[1658177947] linearizableReadLoop","detail":"{readStateIndex:5360; appliedIndex:5357; }","duration":"100.962161ms","start":"2026-09-02T01:19:57.38045Z","end":"2026-09-02T01:19:57.481412Z","steps":["trace[1658177947] 'read index received' (duration: 28.32µs)","trace[1658177947] 'applied index is now lower than readState.Index' (duration: 100.932911ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:19:57.481916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.446504ms","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-02T01:19:57.481978Z","caller":"traceutil/trace.go:171","msg":"trace[1080759134] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5165; }","duration":"101.547514ms","start":"2026-09-02T01:19:57.380421Z","end":"2026-09-02T01:19:57.481969Z","steps":["trace[1080759134] 'agreement among raft nodes before linearized reading' (duration: 101.370613ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:57.481686Z","caller":"traceutil/trace.go:171","msg":"trace[1874998154] transaction","detail":"{read_only:false; response_revision:5163; number_of_response:1; }","duration":"154.651044ms","start":"2026-09-02T01:19:57.327007Z","end":"2026-09-02T01:19:57.481658Z","steps":["trace[1874998154] 'process raft request' (duration: 45.641498ms)","trace[1874998154] 'compare' (duration: 107.752388ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T01:19:57.482305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.043167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-09-02T01:19:57.482454Z","caller":"traceutil/trace.go:171","msg":"trace[2099286892] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5165; }","duration":"100.206697ms","start":"2026-09-02T01:19:57.382206Z","end":"2026-09-02T01:19:57.482412Z","steps":["trace[2099286892] 'agreement among raft nodes before linearized reading' (duration: 99.752995ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:57.481762Z","caller":"traceutil/trace.go:171","msg":"trace[269379446] transaction","detail":"{read_only:false; response_revision:5164; number_of_response:1; }","duration":"154.635684ms","start":"2026-09-02T01:19:57.327117Z","end":"2026-09-02T01:19:57.481753Z","steps":["trace[269379446] 'process raft request' (duration: 154.155802ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:19:57.481784Z","caller":"traceutil/trace.go:171","msg":"trace[1045558094] transaction","detail":"{read_only:false; response_revision:5165; number_of_response:1; }","duration":"154.491843ms","start":"2026-09-02T01:19:57.327274Z","end":"2026-09-02T01:19:57.481766Z","steps":["trace[1045558094] 'process raft request' (duration: 154.098571ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T01:20:23.58484Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2857} {"level":"info","ts":"2026-09-02T01:20:23.664391Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2857,"took":"78.230806ms","hash":2811393945,"current-db-size-bytes":53059584,"current-db-size":"53 MB","current-db-size-in-use-bytes":28160000,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-02T01:20:23.664476Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2811393945,"revision":2857,"compact-revision":-1} {"level":"info","ts":"2026-09-02T01:25:23.5912Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5339} {"level":"info","ts":"2026-09-02T01:25:23.676924Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5339,"took":"84.064311ms","hash":235768259,"current-db-size-bytes":53059584,"current-db-size":"53 MB","current-db-size-in-use-bytes":18747392,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-02T01:25:23.676978Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":235768259,"revision":5339,"compact-revision":2857}