{"level":"warn","ts":"2026-10-17T10:49:58.787423Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T10:49:58.787517Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.148: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.148:2380","--initial-cluster=instance=https://162.253.55.148:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.148:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.148: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-10-17T10:49:58.787575Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T10:49:58.78759Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.148:2380"]} {"level":"info","ts":"2026-10-17T10:49:58.787608Z","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-10-17T10:49:58.788226Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"]} {"level":"info","ts":"2026-10-17T10:49:58.788298Z","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":16,"max-cpu-available":16,"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.148:2380"],"listen-peer-urls":["https://162.253.55.148:2380"],"advertise-client-urls":["https://162.253.55.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.148: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-10-17T10:49:58.79215Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.653788ms"} {"level":"info","ts":"2026-10-17T10:49:58.803556Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a6342599e225e01b","cluster-id":"8ad3da7aa894cc05"} {"level":"info","ts":"2026-10-17T10:49:58.803625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T10:49:58.803647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became follower at term 0"} {"level":"info","ts":"2026-10-17T10:49:58.80366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a6342599e225e01b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T10:49:58.803667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became follower at term 1"} {"level":"info","ts":"2026-10-17T10:49:58.803701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=(11976238651939348507)"} {"level":"warn","ts":"2026-10-17T10:49:58.808873Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T10:49:58.810516Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T10:49:58.811802Z","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-10-17T10:49:58.814189Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a6342599e225e01b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T10:49:58.815032Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a6342599e225e01b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T10:49:58.814994Z","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-10-17T10:49:58.815178Z","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-10-17T10:49:58.815262Z","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-10-17T10:49:58.823116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=(11976238651939348507)"} {"level":"info","ts":"2026-10-17T10:49:58.823366Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ad3da7aa894cc05","local-member-id":"a6342599e225e01b","added-peer-id":"a6342599e225e01b","added-peer-peer-urls":["https://162.253.55.148:2380"]} {"level":"info","ts":"2026-10-17T10:49:58.835714Z","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-10-17T10:49:58.835909Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.148:2380"} {"level":"info","ts":"2026-10-17T10:49:58.835991Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.148:2380"} {"level":"info","ts":"2026-10-17T10:49:58.836206Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a6342599e225e01b","initial-advertise-peer-urls":["https://162.253.55.148:2380"],"listen-peer-urls":["https://162.253.55.148:2380"],"advertise-client-urls":["https://162.253.55.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T10:49:58.836267Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T10:49:58.904674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T10:49:58.904759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T10:49:58.904788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b received MsgPreVoteResp from a6342599e225e01b at term 1"} {"level":"info","ts":"2026-10-17T10:49:58.904806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became candidate at term 2"} {"level":"info","ts":"2026-10-17T10:49:58.904815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b received MsgVoteResp from a6342599e225e01b at term 2"} {"level":"info","ts":"2026-10-17T10:49:58.904827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became leader at term 2"} {"level":"info","ts":"2026-10-17T10:49:58.904841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a6342599e225e01b elected leader a6342599e225e01b at term 2"} {"level":"info","ts":"2026-10-17T10:49:58.905909Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:49:58.906811Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a6342599e225e01b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.148:2379]}","request-path":"/0/members/a6342599e225e01b/attributes","cluster-id":"8ad3da7aa894cc05","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T10:49:58.906846Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:49:58.907032Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:49:58.90727Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T10:49:58.907356Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ad3da7aa894cc05","local-member-id":"a6342599e225e01b","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:49:58.907376Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T10:49:58.907485Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:49:58.907523Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:49:58.910185Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.148:2379"} {"level":"info","ts":"2026-10-17T10:49:58.9108Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T10:50:51.441781Z","caller":"traceutil/trace.go:171","msg":"trace[1560249299] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"106.186605ms","start":"2026-10-17T10:50:51.33554Z","end":"2026-10-17T10:50:51.441727Z","steps":["trace[1560249299] 'process raft request' (duration: 106.016952ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:50:51.832759Z","caller":"traceutil/trace.go:171","msg":"trace[1072180702] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"148.373531ms","start":"2026-10-17T10:50:51.684309Z","end":"2026-10-17T10:50:51.832683Z","steps":["trace[1072180702] 'process raft request' (duration: 147.342412ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:50:51.858591Z","caller":"traceutil/trace.go:171","msg":"trace[219516869] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"141.33392ms","start":"2026-10-17T10:50:51.717187Z","end":"2026-10-17T10:50:51.858521Z","steps":["trace[219516869] 'read index received' (duration: 114.550882ms)","trace[219516869] 'applied index is now lower than readState.Index' (duration: 26.781498ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:50:51.858681Z","caller":"traceutil/trace.go:171","msg":"trace[1071540100] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"141.729497ms","start":"2026-10-17T10:50:51.716896Z","end":"2026-10-17T10:50:51.858626Z","steps":["trace[1071540100] 'process raft request' (duration: 141.086754ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:51.858811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.602875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-75q5s\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-17T10:50:51.858884Z","caller":"traceutil/trace.go:171","msg":"trace[1188574138] range","detail":"{range_begin:/registry/pods/kube-system/cilium-75q5s; range_end:; response_count:1; response_revision:602; }","duration":"141.743748ms","start":"2026-10-17T10:50:51.717127Z","end":"2026-10-17T10:50:51.858871Z","steps":["trace[1188574138] 'agreement among raft nodes before linearized reading' (duration: 141.528644ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:52.345832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.578123ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:50:52.346053Z","caller":"traceutil/trace.go:171","msg":"trace[431394063] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"198.589125ms","start":"2026-10-17T10:50:52.147444Z","end":"2026-10-17T10:50:52.346034Z","steps":["trace[431394063] 'process raft request' (duration: 198.483763ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:50:52.346105Z","caller":"traceutil/trace.go:171","msg":"trace[2057720530] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"406.078296ms","start":"2026-10-17T10:50:51.939988Z","end":"2026-10-17T10:50:52.346066Z","steps":["trace[2057720530] 'read index received' (duration: 298.633216ms)","trace[2057720530] 'applied index is now lower than readState.Index' (duration: 107.44187ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:50:52.346136Z","caller":"traceutil/trace.go:171","msg":"trace[1827348656] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"466.680733ms","start":"2026-10-17T10:50:51.879401Z","end":"2026-10-17T10:50:52.346082Z","steps":["trace[1827348656] 'process raft request' (duration: 359.133512ms)","trace[1827348656] 'compare' (duration: 106.117964ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:50:52.346363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.276371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-17T10:50:52.34635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:50:51.879364Z","time spent":"466.870477ms","remote":"127.0.0.1:51446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:50:52.346504Z","caller":"traceutil/trace.go:171","msg":"trace[2048325611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"226.417332ms","start":"2026-10-17T10:50:52.120019Z","end":"2026-10-17T10:50:52.346436Z","steps":["trace[2048325611] 'agreement among raft nodes before linearized reading' (duration: 226.249509ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:52.346437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.890348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:50:52.346618Z","caller":"traceutil/trace.go:171","msg":"trace[2084442363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"352.183313ms","start":"2026-10-17T10:50:51.994385Z","end":"2026-10-17T10:50:52.346569Z","steps":["trace[2084442363] 'agreement among raft nodes before linearized reading' (duration: 351.886467ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:52.346693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:50:51.994362Z","time spent":"352.317956ms","remote":"127.0.0.1:51292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-17T10:50:52.347127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.138265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:50:52.347191Z","caller":"traceutil/trace.go:171","msg":"trace[816608207] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:604; }","duration":"407.254177ms","start":"2026-10-17T10:50:51.939917Z","end":"2026-10-17T10:50:52.347171Z","steps":["trace[816608207] 'agreement among raft nodes before linearized reading' (duration: 406.288709ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:50:52.347387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:50:51.939882Z","time spent":"407.339579ms","remote":"127.0.0.1:51476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-10-17T10:50:53.999555Z","caller":"traceutil/trace.go:171","msg":"trace[1283871998] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"113.472771ms","start":"2026-10-17T10:50:53.886055Z","end":"2026-10-17T10:50:53.999528Z","steps":["trace[1283871998] 'process raft request' (duration: 113.281998ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:51:07.554642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.275175ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:51:07.554826Z","caller":"traceutil/trace.go:171","msg":"trace[650331181] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"346.994617ms","start":"2026-10-17T10:51:07.207805Z","end":"2026-10-17T10:51:07.554799Z","steps":["trace[650331181] 'process raft request' (duration: 37.372885ms)","trace[650331181] 'compare' (duration: 309.03374ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:51:07.554899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:51:07.207789Z","time spent":"347.080148ms","remote":"127.0.0.1:51548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:51:36.347157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.796543ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:51:36.34743Z","caller":"traceutil/trace.go:171","msg":"trace[302153152] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"147.642097ms","start":"2026-10-17T10:51:36.199767Z","end":"2026-10-17T10:51:36.347409Z","steps":["trace[302153152] 'process raft request' (duration: 147.507615ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:51:36.347451Z","caller":"traceutil/trace.go:171","msg":"trace[1250430128] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"276.420153ms","start":"2026-10-17T10:51:36.070991Z","end":"2026-10-17T10:51:36.347411Z","steps":["trace[1250430128] 'process raft request' (duration: 101.267454ms)","trace[1250430128] 'compare' (duration: 174.62674ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:52:25.387493Z","caller":"traceutil/trace.go:171","msg":"trace[693572603] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"120.908752ms","start":"2026-10-17T10:52:25.266523Z","end":"2026-10-17T10:52:25.387432Z","steps":["trace[693572603] 'process raft request' (duration: 120.706927ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:25.843004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.96063ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:52:25.843344Z","caller":"traceutil/trace.go:171","msg":"trace[2049071788] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"448.114189ms","start":"2026-10-17T10:52:25.395147Z","end":"2026-10-17T10:52:25.843261Z","steps":["trace[2049071788] 'process raft request' (duration: 447.968746ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:25.843541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.395138Z","time spent":"448.301322ms","remote":"127.0.0.1:51550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:52:25.843573Z","caller":"traceutil/trace.go:171","msg":"trace[1358952484] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"448.211081ms","start":"2026-10-17T10:52:25.395315Z","end":"2026-10-17T10:52:25.843527Z","steps":["trace[1358952484] 'process raft request' (duration: 447.883335ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:25.843299Z","caller":"traceutil/trace.go:171","msg":"trace[2052612583] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"448.229722ms","start":"2026-10-17T10:52:25.395005Z","end":"2026-10-17T10:52:25.843234Z","steps":["trace[2052612583] 'process raft request' (duration: 305.931546ms)","trace[2052612583] 'compare' (duration: 141.826107ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:52:25.843694Z","caller":"traceutil/trace.go:171","msg":"trace[547815039] linearizableReadLoop","detail":"{readStateIndex:1927; appliedIndex:1923; }","duration":"127.221097ms","start":"2026-10-17T10:52:25.716394Z","end":"2026-10-17T10:52:25.843615Z","steps":["trace[547815039] 'read index received' (duration: 99.492µs)","trace[547815039] 'applied index is now lower than readState.Index' (duration: 127.120195ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:52:25.843798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.395277Z","time spent":"448.403315ms","remote":"127.0.0.1:51428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:52:25.843886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.394985Z","time spent":"448.761891ms","remote":"127.0.0.1:51550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:52:25.843947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.556134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-10-17T10:52:25.844023Z","caller":"traceutil/trace.go:171","msg":"trace[1352665038] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1857; }","duration":"127.694716ms","start":"2026-10-17T10:52:25.716304Z","end":"2026-10-17T10:52:25.843999Z","steps":["trace[1352665038] 'agreement among raft nodes before linearized reading' (duration: 127.448741ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:25.843711Z","caller":"traceutil/trace.go:171","msg":"trace[778415637] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"443.86691ms","start":"2026-10-17T10:52:25.399774Z","end":"2026-10-17T10:52:25.843641Z","steps":["trace[778415637] 'process raft request' (duration: 443.645426ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:25.844572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:25.39976Z","time spent":"444.739587ms","remote":"127.0.0.1:51446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:52:26.621398Z","caller":"traceutil/trace.go:171","msg":"trace[1297589231] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"190.481605ms","start":"2026-10-17T10:52:26.430856Z","end":"2026-10-17T10:52:26.621337Z","steps":["trace[1297589231] 'process raft request' (duration: 157.478455ms)","trace[1297589231] 'compare' (duration: 32.726405ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:52:39.527774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.825126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-17T10:52:39.527884Z","caller":"traceutil/trace.go:171","msg":"trace[1007030503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1974; }","duration":"304.002789ms","start":"2026-10-17T10:52:39.223858Z","end":"2026-10-17T10:52:39.527861Z","steps":["trace[1007030503] 'range keys from in-memory index tree' (duration: 303.609622ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:39.527961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.682724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T10:52:39.527785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.119494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-17T10:52:39.528201Z","caller":"traceutil/trace.go:171","msg":"trace[1384194763] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1974; }","duration":"122.99996ms","start":"2026-10-17T10:52:39.405146Z","end":"2026-10-17T10:52:39.528146Z","steps":["trace[1384194763] 'count revisions from in-memory index tree' (duration: 122.573722ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:39.528225Z","caller":"traceutil/trace.go:171","msg":"trace[720149322] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1974; }","duration":"277.637294ms","start":"2026-10-17T10:52:39.250554Z","end":"2026-10-17T10:52:39.528191Z","steps":["trace[720149322] 'range keys from in-memory index tree' (duration: 276.86965ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:52:39.527933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:52:39.223832Z","time spent":"304.091981ms","remote":"127.0.0.1:51548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-17T10:52:42.835401Z","caller":"traceutil/trace.go:171","msg":"trace[691903429] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"141.97244ms","start":"2026-10-17T10:52:42.693401Z","end":"2026-10-17T10:52:42.835373Z","steps":["trace[691903429] 'process raft request' (duration: 141.792987ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:42.836546Z","caller":"traceutil/trace.go:171","msg":"trace[90876219] linearizableReadLoop","detail":"{readStateIndex:2068; appliedIndex:2066; }","duration":"128.418689ms","start":"2026-10-17T10:52:42.7081Z","end":"2026-10-17T10:52:42.836519Z","steps":["trace[90876219] 'read index received' (duration: 127.158876ms)","trace[90876219] 'applied index is now lower than readState.Index' (duration: 1.258683ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:52:42.836844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.730165ms","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-10-17T10:52:42.836883Z","caller":"traceutil/trace.go:171","msg":"trace[1013049446] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1993; }","duration":"128.840238ms","start":"2026-10-17T10:52:42.708027Z","end":"2026-10-17T10:52:42.836867Z","steps":["trace[1013049446] 'agreement among raft nodes before linearized reading' (duration: 128.595884ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:52:42.836867Z","caller":"traceutil/trace.go:171","msg":"trace[1592622307] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"143.286814ms","start":"2026-10-17T10:52:42.693554Z","end":"2026-10-17T10:52:42.836841Z","steps":["trace[1592622307] 'process raft request' (duration: 142.790905ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:53:16.062017Z","caller":"traceutil/trace.go:171","msg":"trace[1269130080] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"255.277678ms","start":"2026-10-17T10:53:15.8067Z","end":"2026-10-17T10:53:16.061978Z","steps":["trace[1269130080] 'process raft request' (duration: 195.082725ms)","trace[1269130080] 'compare' (duration: 59.890018ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:53:22.254507Z","caller":"traceutil/trace.go:171","msg":"trace[1981721243] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"152.0199ms","start":"2026-10-17T10:53:22.102393Z","end":"2026-10-17T10:53:22.254412Z","steps":["trace[1981721243] 'process raft request' (duration: 151.762045ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:04.867038Z","caller":"traceutil/trace.go:171","msg":"trace[96146523] transaction","detail":"{read_only:false; response_revision:2612; number_of_response:1; }","duration":"126.981368ms","start":"2026-10-17T10:54:04.740029Z","end":"2026-10-17T10:54:04.86701Z","steps":["trace[96146523] 'process raft request' (duration: 126.696353ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:38.454547Z","caller":"traceutil/trace.go:171","msg":"trace[1609056432] transaction","detail":"{read_only:false; response_revision:2815; number_of_response:1; }","duration":"146.047023ms","start":"2026-10-17T10:54:38.308478Z","end":"2026-10-17T10:54:38.454525Z","steps":["trace[1609056432] 'process raft request' (duration: 145.820558ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:56.635878Z","caller":"traceutil/trace.go:171","msg":"trace[158438738] linearizableReadLoop","detail":"{readStateIndex:4212; appliedIndex:4211; }","duration":"112.708936ms","start":"2026-10-17T10:57:56.523142Z","end":"2026-10-17T10:57:56.635851Z","steps":["trace[158438738] 'read index received' (duration: 112.541353ms)","trace[158438738] 'applied index is now lower than readState.Index' (duration: 166.563µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:57:56.636092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.91985ms","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-10-17T10:57:56.636047Z","caller":"traceutil/trace.go:171","msg":"trace[2144258223] transaction","detail":"{read_only:false; response_revision:4059; number_of_response:1; }","duration":"137.340434ms","start":"2026-10-17T10:57:56.498677Z","end":"2026-10-17T10:57:56.636017Z","steps":["trace[2144258223] 'process raft request' (duration: 136.949937ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:56.636152Z","caller":"traceutil/trace.go:171","msg":"trace[1474119930] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4059; }","duration":"113.035622ms","start":"2026-10-17T10:57:56.5231Z","end":"2026-10-17T10:57:56.636136Z","steps":["trace[1474119930] 'agreement among raft nodes before linearized reading' (duration: 112.91822ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:59:35.827646Z","caller":"traceutil/trace.go:171","msg":"trace[282177906] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"134.085557ms","start":"2026-10-17T10:59:35.693521Z","end":"2026-10-17T10:59:35.827606Z","steps":["trace[282177906] 'process raft request' (duration: 134.000194ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:59:35.827681Z","caller":"traceutil/trace.go:171","msg":"trace[309590058] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"135.464472ms","start":"2026-10-17T10:59:35.692178Z","end":"2026-10-17T10:59:35.827643Z","steps":["trace[309590058] 'process raft request' (duration: 86.841696ms)","trace[309590058] 'compare' (duration: 48.258419ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:59:51.258278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.463024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:59:51.258405Z","caller":"traceutil/trace.go:171","msg":"trace[1786123312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5577; }","duration":"264.597627ms","start":"2026-10-17T10:59:50.993764Z","end":"2026-10-17T10:59:51.258361Z","steps":["trace[1786123312] 'range keys from in-memory index tree' (duration: 264.386372ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:59:51.417057Z","caller":"traceutil/trace.go:171","msg":"trace[600618971] transaction","detail":"{read_only:false; response_revision:5578; number_of_response:1; }","duration":"154.178951ms","start":"2026-10-17T10:59:51.262847Z","end":"2026-10-17T10:59:51.417026Z","steps":["trace[600618971] 'process raft request' (duration: 153.935356ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:59:51.559316Z","caller":"traceutil/trace.go:171","msg":"trace[443229457] transaction","detail":"{read_only:false; response_revision:5579; number_of_response:1; }","duration":"296.407918ms","start":"2026-10-17T10:59:51.262886Z","end":"2026-10-17T10:59:51.559294Z","steps":["trace[443229457] 'process raft request' (duration: 237.089904ms)","trace[443229457] 'compare' (duration: 59.226823ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:59:58.718781Z","caller":"traceutil/trace.go:171","msg":"trace[567865635] transaction","detail":"{read_only:false; response_revision:5738; number_of_response:1; }","duration":"110.452256ms","start":"2026-10-17T10:59:58.608302Z","end":"2026-10-17T10:59:58.718754Z","steps":["trace[567865635] 'process raft request' (duration: 35.430479ms)","trace[567865635] 'compare' (duration: 74.868224ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:59:59.017311Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2927} {"level":"info","ts":"2026-10-17T10:59:59.113117Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2927,"took":"94.189584ms","hash":2468389554,"current-db-size-bytes":56188928,"current-db-size":"56 MB","current-db-size-in-use-bytes":31879168,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T10:59:59.113209Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2468389554,"revision":2927,"compact-revision":-1} {"level":"info","ts":"2026-10-17T11:00:51.194682Z","caller":"traceutil/trace.go:171","msg":"trace[1980612676] linearizableReadLoop","detail":"{readStateIndex:6474; appliedIndex:6473; }","duration":"103.757641ms","start":"2026-10-17T11:00:51.09089Z","end":"2026-10-17T11:00:51.194648Z","steps":["trace[1980612676] 'read index received' (duration: 84.067245ms)","trace[1980612676] 'applied index is now lower than readState.Index' (duration: 19.689096ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:00:51.194774Z","caller":"traceutil/trace.go:171","msg":"trace[111692653] transaction","detail":"{read_only:false; response_revision:6249; number_of_response:1; }","duration":"110.640009ms","start":"2026-10-17T11:00:51.084099Z","end":"2026-10-17T11:00:51.194739Z","steps":["trace[111692653] 'process raft request' (duration: 90.910212ms)","trace[111692653] 'compare' (duration: 19.441861ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:00:51.194964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.054856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gvmvd\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-10-17T11:00:51.19506Z","caller":"traceutil/trace.go:171","msg":"trace[939496136] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gvmvd; range_end:; response_count:1; response_revision:6249; }","duration":"104.202299ms","start":"2026-10-17T11:00:51.090837Z","end":"2026-10-17T11:00:51.195039Z","steps":["trace[939496136] 'agreement among raft nodes before linearized reading' (duration: 103.935334ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:04:59.024225Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5753} {"level":"info","ts":"2026-10-17T11:04:59.116994Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5753,"took":"90.814735ms","hash":4238793459,"current-db-size-bytes":56188928,"current-db-size":"56 MB","current-db-size-in-use-bytes":25559040,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T11:04:59.117058Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4238793459,"revision":5753,"compact-revision":2927} {"level":"info","ts":"2026-10-17T11:06:07.278209Z","caller":"traceutil/trace.go:171","msg":"trace[150166513] linearizableReadLoop","detail":"{readStateIndex:8881; appliedIndex:8880; }","duration":"210.509017ms","start":"2026-10-17T11:06:07.067674Z","end":"2026-10-17T11:06:07.278183Z","steps":["trace[150166513] 'read index received' (duration: 210.192401ms)","trace[150166513] 'applied index is now lower than readState.Index' (duration: 315.306µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:06:07.278299Z","caller":"traceutil/trace.go:171","msg":"trace[2115964406] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"293.411623ms","start":"2026-10-17T11:06:06.984843Z","end":"2026-10-17T11:06:07.278254Z","steps":["trace[2115964406] 'process raft request' (duration: 293.182729ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:07.278467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.327021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gvmvd\" ","response":"range_response_count:1 size:6522"} {"level":"warn","ts":"2026-10-17T11:06:07.278468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.778353ms","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-10-17T11:06:07.278516Z","caller":"traceutil/trace.go:171","msg":"trace[1471103057] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gvmvd; range_end:; response_count:1; response_revision:8582; }","duration":"205.414222ms","start":"2026-10-17T11:06:07.073092Z","end":"2026-10-17T11:06:07.278507Z","steps":["trace[1471103057] 'agreement among raft nodes before linearized reading' (duration: 205.235449ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:06:07.278525Z","caller":"traceutil/trace.go:171","msg":"trace[471298590] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8582; }","duration":"210.904585ms","start":"2026-10-17T11:06:07.067612Z","end":"2026-10-17T11:06:07.278517Z","steps":["trace[471298590] 'agreement among raft nodes before linearized reading' (duration: 210.711372ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:06:07.440347Z","caller":"traceutil/trace.go:171","msg":"trace[1800164875] linearizableReadLoop","detail":"{readStateIndex:8882; appliedIndex:8881; }","duration":"133.574202ms","start":"2026-10-17T11:06:07.306743Z","end":"2026-10-17T11:06:07.440318Z","steps":["trace[1800164875] 'read index received' (duration: 131.87341ms)","trace[1800164875] 'applied index is now lower than readState.Index' (duration: 1.699191ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:06:07.440432Z","caller":"traceutil/trace.go:171","msg":"trace[1852080743] transaction","detail":"{read_only:false; response_revision:8583; number_of_response:1; }","duration":"156.273556ms","start":"2026-10-17T11:06:07.284071Z","end":"2026-10-17T11:06:07.440345Z","steps":["trace[1852080743] 'process raft request' (duration: 154.718337ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:07.440683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.910467ms","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-10-17T11:06:07.440797Z","caller":"traceutil/trace.go:171","msg":"trace[1243290639] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8583; }","duration":"134.102081ms","start":"2026-10-17T11:06:07.30667Z","end":"2026-10-17T11:06:07.440772Z","steps":["trace[1243290639] 'agreement among raft nodes before linearized reading' (duration: 133.764295ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:06:19.128925Z","caller":"traceutil/trace.go:171","msg":"trace[1381291283] linearizableReadLoop","detail":"{readStateIndex:8946; appliedIndex:8945; }","duration":"133.647124ms","start":"2026-10-17T11:06:18.995244Z","end":"2026-10-17T11:06:19.128891Z","steps":["trace[1381291283] 'read index received' (duration: 133.405339ms)","trace[1381291283] 'applied index is now lower than readState.Index' (duration: 240.105µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:06:19.129007Z","caller":"traceutil/trace.go:171","msg":"trace[499825951] transaction","detail":"{read_only:false; response_revision:8643; number_of_response:1; }","duration":"245.311657ms","start":"2026-10-17T11:06:18.88364Z","end":"2026-10-17T11:06:19.128952Z","steps":["trace[499825951] 'process raft request' (duration: 245.056202ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:19.129081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.824718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:06:19.12912Z","caller":"traceutil/trace.go:171","msg":"trace[1618737407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8643; }","duration":"133.95656ms","start":"2026-10-17T11:06:18.995151Z","end":"2026-10-17T11:06:19.129108Z","steps":["trace[1618737407] 'agreement among raft nodes before linearized reading' (duration: 133.862728ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:06:19.907911Z","caller":"traceutil/trace.go:171","msg":"trace[60075560] transaction","detail":"{read_only:false; response_revision:8646; number_of_response:1; }","duration":"374.169772ms","start":"2026-10-17T11:06:19.533708Z","end":"2026-10-17T11:06:19.907878Z","steps":["trace[60075560] 'process raft request' (duration: 373.904077ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:19.908122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:06:19.533686Z","time spent":"374.322305ms","remote":"127.0.0.1:51548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:06:19.920811Z","caller":"traceutil/trace.go:171","msg":"trace[1832113920] transaction","detail":"{read_only:false; response_revision:8647; number_of_response:1; }","duration":"341.690826ms","start":"2026-10-17T11:06:19.579092Z","end":"2026-10-17T11:06:19.920783Z","steps":["trace[1832113920] 'process raft request' (duration: 341.532333ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:19.920967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:06:19.579075Z","time spent":"341.808968ms","remote":"127.0.0.1:51548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:06:20.921521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.936268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:06:20.921654Z","caller":"traceutil/trace.go:171","msg":"trace[1527847851] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:8652; }","duration":"300.149462ms","start":"2026-10-17T11:06:20.621474Z","end":"2026-10-17T11:06:20.921624Z","steps":["trace[1527847851] 'count revisions from in-memory index tree' (duration: 299.816334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:20.921721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:06:20.621454Z","time spent":"300.252123ms","remote":"127.0.0.1:46116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-10-17T11:06:20.976563Z","caller":"traceutil/trace.go:171","msg":"trace[116177656] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"166.617728ms","start":"2026-10-17T11:06:20.809912Z","end":"2026-10-17T11:06:20.97653Z","steps":["trace[116177656] 'process raft request' (duration: 166.418725ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:21.252162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.705415ms","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-10-17T11:06:21.252327Z","caller":"traceutil/trace.go:171","msg":"trace[1083529475] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8653; }","duration":"118.918429ms","start":"2026-10-17T11:06:21.133344Z","end":"2026-10-17T11:06:21.252262Z","steps":["trace[1083529475] 'range keys from in-memory index tree' (duration: 118.44855ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:06:50.000136Z","caller":"traceutil/trace.go:171","msg":"trace[2133593415] transaction","detail":"{read_only:false; response_revision:8861; number_of_response:1; }","duration":"240.010175ms","start":"2026-10-17T11:06:49.760099Z","end":"2026-10-17T11:06:50.000109Z","steps":["trace[2133593415] 'process raft request' (duration: 239.455205ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:06:52.478001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.99736ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:06:52.47841Z","caller":"traceutil/trace.go:171","msg":"trace[946201830] transaction","detail":"{read_only:false; response_revision:8874; number_of_response:1; }","duration":"281.838988ms","start":"2026-10-17T11:06:52.196543Z","end":"2026-10-17T11:06:52.478382Z","steps":["trace[946201830] 'process raft request' (duration: 159.365389ms)","trace[946201830] 'compare' (duration: 121.857417ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:06:52.478692Z","caller":"traceutil/trace.go:171","msg":"trace[1361135921] linearizableReadLoop","detail":"{readStateIndex:9187; appliedIndex:9184; }","duration":"111.865121ms","start":"2026-10-17T11:06:52.366814Z","end":"2026-10-17T11:06:52.478679Z","steps":["trace[1361135921] 'read index received' (duration: 12.660266ms)","trace[1361135921] 'applied index is now lower than readState.Index' (duration: 99.203865ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:06:52.478858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.036104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-17T11:06:52.478832Z","caller":"traceutil/trace.go:171","msg":"trace[235909949] transaction","detail":"{read_only:false; response_revision:8876; number_of_response:1; }","duration":"221.49946ms","start":"2026-10-17T11:06:52.257299Z","end":"2026-10-17T11:06:52.478798Z","steps":["trace[235909949] 'process raft request' (duration: 221.323557ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:06:52.478868Z","caller":"traceutil/trace.go:171","msg":"trace[2774296] transaction","detail":"{read_only:false; response_revision:8875; number_of_response:1; }","duration":"237.117063ms","start":"2026-10-17T11:06:52.241725Z","end":"2026-10-17T11:06:52.478842Z","steps":["trace[2774296] 'process raft request' (duration: 236.377629ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:06:52.478889Z","caller":"traceutil/trace.go:171","msg":"trace[910719420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8876; }","duration":"112.097136ms","start":"2026-10-17T11:06:52.36678Z","end":"2026-10-17T11:06:52.478878Z","steps":["trace[910719420] 'agreement among raft nodes before linearized reading' (duration: 111.949723ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:03.697334Z","caller":"traceutil/trace.go:171","msg":"trace[1809861713] transaction","detail":"{read_only:false; response_revision:8942; number_of_response:1; }","duration":"662.793778ms","start":"2026-10-17T11:07:03.034514Z","end":"2026-10-17T11:07:03.697308Z","steps":["trace[1809861713] 'process raft request' (duration: 662.540034ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:03.697485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.226411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:07:03.697555Z","caller":"traceutil/trace.go:171","msg":"trace[250636510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8943; }","duration":"400.338594ms","start":"2026-10-17T11:07:03.297197Z","end":"2026-10-17T11:07:03.697536Z","steps":["trace[250636510] 'agreement among raft nodes before linearized reading' (duration: 400.202141ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:03.697502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:07:03.034467Z","time spent":"662.956181ms","remote":"127.0.0.1:51446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4798,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:07:03.697722Z","caller":"traceutil/trace.go:171","msg":"trace[1350642865] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8943; }","duration":"663.022833ms","start":"2026-10-17T11:07:03.034664Z","end":"2026-10-17T11:07:03.697686Z","steps":["trace[1350642865] 'process raft request' (duration: 662.559695ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:03.697804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:07:03.297172Z","time spent":"400.614538ms","remote":"127.0.0.1:51278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-17T11:07:03.697314Z","caller":"traceutil/trace.go:171","msg":"trace[741623978] linearizableReadLoop","detail":"{readStateIndex:9257; appliedIndex:9255; }","duration":"400.032758ms","start":"2026-10-17T11:07:03.297257Z","end":"2026-10-17T11:07:03.697289Z","steps":["trace[741623978] 'read index received' (duration: 399.720982ms)","trace[741623978] 'applied index is now lower than readState.Index' (duration: 310.456µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:07:03.697946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:07:03.034656Z","time spent":"663.151196ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59,"response count":0,"response size":42,"request content":"compare: success: > failure: >"} {"level":"warn","ts":"2026-10-17T11:07:03.698072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.59046ms","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-10-17T11:07:03.698108Z","caller":"traceutil/trace.go:171","msg":"trace[2099120459] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8943; }","duration":"208.646491ms","start":"2026-10-17T11:07:03.489448Z","end":"2026-10-17T11:07:03.698095Z","steps":["trace[2099120459] 'agreement among raft nodes before linearized reading' (duration: 208.527648ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:03.698708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.224368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-7tdzt\" ","response":"range_response_count:1 size:4813"} {"level":"info","ts":"2026-10-17T11:07:03.698801Z","caller":"traceutil/trace.go:171","msg":"trace[102358558] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-7tdzt; range_end:; response_count:1; response_revision:8943; }","duration":"127.912661ms","start":"2026-10-17T11:07:03.570864Z","end":"2026-10-17T11:07:03.698777Z","steps":["trace[102358558] 'agreement among raft nodes before linearized reading' (duration: 127.170057ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:03.825424Z","caller":"traceutil/trace.go:171","msg":"trace[1614112750] transaction","detail":"{read_only:false; response_revision:8944; number_of_response:1; }","duration":"121.752927ms","start":"2026-10-17T11:07:03.703636Z","end":"2026-10-17T11:07:03.825389Z","steps":["trace[1614112750] 'process raft request' (duration: 95.531837ms)","trace[1614112750] 'compare' (duration: 26.044747ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:07:03.836381Z","caller":"traceutil/trace.go:171","msg":"trace[1312568354] linearizableReadLoop","detail":"{readStateIndex:9259; appliedIndex:9257; }","duration":"129.528051ms","start":"2026-10-17T11:07:03.706806Z","end":"2026-10-17T11:07:03.836334Z","steps":["trace[1312568354] 'read index received' (duration: 92.386187ms)","trace[1312568354] 'applied index is now lower than readState.Index' (duration: 37.140334ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:07:03.836763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.931659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gvmvd\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-10-17T11:07:03.83683Z","caller":"traceutil/trace.go:171","msg":"trace[550147201] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gvmvd; range_end:; response_count:1; response_revision:8946; }","duration":"130.051381ms","start":"2026-10-17T11:07:03.706761Z","end":"2026-10-17T11:07:03.836812Z","steps":["trace[550147201] 'agreement among raft nodes before linearized reading' (duration: 129.833657ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:03.836796Z","caller":"traceutil/trace.go:171","msg":"trace[1691213544] transaction","detail":"{read_only:false; response_revision:8946; number_of_response:1; }","duration":"129.475ms","start":"2026-10-17T11:07:03.707273Z","end":"2026-10-17T11:07:03.836748Z","steps":["trace[1691213544] 'process raft request' (duration: 129.002581ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:03.836824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.507251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-7tdzt\" ","response":"range_response_count:1 size:4769"} {"level":"info","ts":"2026-10-17T11:07:03.836856Z","caller":"traceutil/trace.go:171","msg":"trace[804108835] transaction","detail":"{read_only:false; response_revision:8945; number_of_response:1; }","duration":"131.878045ms","start":"2026-10-17T11:07:03.704937Z","end":"2026-10-17T11:07:03.836815Z","steps":["trace[804108835] 'process raft request' (duration: 131.226793ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:03.83694Z","caller":"traceutil/trace.go:171","msg":"trace[520539695] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-7tdzt; range_end:; response_count:1; response_revision:8946; }","duration":"122.848896ms","start":"2026-10-17T11:07:03.714073Z","end":"2026-10-17T11:07:03.836922Z","steps":["trace[520539695] 'agreement among raft nodes before linearized reading' (duration: 122.633342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:03.837113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.04191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-7tdzt\" ","response":"range_response_count:1 size:2803"} {"level":"info","ts":"2026-10-17T11:07:03.837191Z","caller":"traceutil/trace.go:171","msg":"trace[1793960041] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-7tdzt; range_end:; response_count:1; response_revision:8946; }","duration":"123.201333ms","start":"2026-10-17T11:07:03.713971Z","end":"2026-10-17T11:07:03.837173Z","steps":["trace[1793960041] 'agreement among raft nodes before linearized reading' (duration: 122.642472ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:10.375496Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002486.wal"} {"level":"info","ts":"2026-10-17T11:08:10.919954Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:08:10.926552Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T11:08:10.926694Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T11:09:59.030403Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7990} {"level":"info","ts":"2026-10-17T11:09:59.101195Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7990,"took":"68.726951ms","hash":441562068,"current-db-size-bytes":56188928,"current-db-size":"56 MB","current-db-size-in-use-bytes":28385280,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T11:09:59.101361Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":441562068,"revision":7990,"compact-revision":5753} {"level":"info","ts":"2026-10-17T11:12:17.853343Z","caller":"traceutil/trace.go:171","msg":"trace[1748288199] linearizableReadLoop","detail":"{readStateIndex:12042; appliedIndex:12040; }","duration":"216.332171ms","start":"2026-10-17T11:12:17.636968Z","end":"2026-10-17T11:12:17.8533Z","steps":["trace[1748288199] 'read index received' (duration: 6.269337ms)","trace[1748288199] 'applied index is now lower than readState.Index' (duration: 210.061513ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:12:17.85341Z","caller":"traceutil/trace.go:171","msg":"trace[1229114952] transaction","detail":"{read_only:false; response_revision:11648; number_of_response:1; }","duration":"228.498757ms","start":"2026-10-17T11:12:17.624879Z","end":"2026-10-17T11:12:17.853378Z","steps":["trace[1229114952] 'process raft request' (duration: 228.257383ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:12:17.853562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.570255ms","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-10-17T11:12:17.853603Z","caller":"traceutil/trace.go:171","msg":"trace[1837112373] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11648; }","duration":"216.656227ms","start":"2026-10-17T11:12:17.636936Z","end":"2026-10-17T11:12:17.853592Z","steps":["trace[1837112373] 'agreement among raft nodes before linearized reading' (duration: 216.506204ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:12:17.867471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.00525ms","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-10-17T11:12:17.867534Z","caller":"traceutil/trace.go:171","msg":"trace[1520157264] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11651; }","duration":"175.106812ms","start":"2026-10-17T11:12:17.692413Z","end":"2026-10-17T11:12:17.86752Z","steps":["trace[1520157264] 'agreement among raft nodes before linearized reading' (duration: 174.905329ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:12:17.982877Z","caller":"traceutil/trace.go:171","msg":"trace[336344353] transaction","detail":"{read_only:false; response_revision:11653; number_of_response:1; }","duration":"111.341605ms","start":"2026-10-17T11:12:17.871506Z","end":"2026-10-17T11:12:17.982848Z","steps":["trace[336344353] 'process raft request' (duration: 111.192621ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:12:18.358356Z","caller":"traceutil/trace.go:171","msg":"trace[1290961002] transaction","detail":"{read_only:false; response_revision:11656; number_of_response:1; }","duration":"118.560639ms","start":"2026-10-17T11:12:18.239744Z","end":"2026-10-17T11:12:18.358304Z","steps":["trace[1290961002] 'process raft request' (duration: 90.639599ms)","trace[1290961002] 'compare' (duration: 27.813648ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:14:59.038175Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10404} {"level":"info","ts":"2026-10-17T11:14:59.134255Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10404,"took":"93.628989ms","hash":2522218746,"current-db-size-bytes":56188928,"current-db-size":"56 MB","current-db-size-in-use-bytes":27455488,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T11:14:59.134348Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2522218746,"revision":10404,"compact-revision":7990} {"level":"warn","ts":"2026-10-17T11:18:46.573961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.631098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-17T11:18:46.574059Z","caller":"traceutil/trace.go:171","msg":"trace[2005937571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14261; }","duration":"115.78172ms","start":"2026-10-17T11:18:46.458256Z","end":"2026-10-17T11:18:46.574038Z","steps":["trace[2005937571] 'range keys from in-memory index tree' (duration: 115.417664ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:18:46.574297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.93641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-17T11:18:46.574426Z","caller":"traceutil/trace.go:171","msg":"trace[973949422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14261; }","duration":"142.133654ms","start":"2026-10-17T11:18:46.432269Z","end":"2026-10-17T11:18:46.574403Z","steps":["trace[973949422] 'range keys from in-memory index tree' (duration: 141.674856ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:18:46.736862Z","caller":"traceutil/trace.go:171","msg":"trace[247990619] linearizableReadLoop","detail":"{readStateIndex:14751; appliedIndex:14748; }","duration":"110.748406ms","start":"2026-10-17T11:18:46.626088Z","end":"2026-10-17T11:18:46.736836Z","steps":["trace[247990619] 'read index received' (duration: 9.849895ms)","trace[247990619] 'applied index is now lower than readState.Index' (duration: 100.897291ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:18:46.737064Z","caller":"traceutil/trace.go:171","msg":"trace[1866386024] transaction","detail":"{read_only:false; response_revision:14263; number_of_response:1; }","duration":"157.536082ms","start":"2026-10-17T11:18:46.579464Z","end":"2026-10-17T11:18:46.737Z","steps":["trace[1866386024] 'process raft request' (duration: 156.87934ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:18:46.737132Z","caller":"traceutil/trace.go:171","msg":"trace[294835399] transaction","detail":"{read_only:false; response_revision:14264; number_of_response:1; }","duration":"157.605563ms","start":"2026-10-17T11:18:46.57949Z","end":"2026-10-17T11:18:46.737096Z","steps":["trace[294835399] 'process raft request' (duration: 157.292507ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:18:46.737044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.933719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:18:46.737495Z","caller":"traceutil/trace.go:171","msg":"trace[551663580] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:14264; }","duration":"111.383328ms","start":"2026-10-17T11:18:46.626069Z","end":"2026-10-17T11:18:46.737452Z","steps":["trace[551663580] 'agreement among raft nodes before linearized reading' (duration: 110.874158ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:18:57.151812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.069579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:18:57.15191Z","caller":"traceutil/trace.go:171","msg":"trace[1600315081] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:14434; }","duration":"209.222321ms","start":"2026-10-17T11:18:56.942658Z","end":"2026-10-17T11:18:57.15188Z","steps":["trace[1600315081] 'count revisions from in-memory index tree' (duration: 208.957616ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:18:57.353743Z","caller":"traceutil/trace.go:171","msg":"trace[1914255557] transaction","detail":"{read_only:false; response_revision:14435; number_of_response:1; }","duration":"110.707295ms","start":"2026-10-17T11:18:57.242989Z","end":"2026-10-17T11:18:57.353697Z","steps":["trace[1914255557] 'process raft request' (duration: 110.43142ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:19:59.046357Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12720} {"level":"info","ts":"2026-10-17T11:19:59.134779Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12720,"took":"86.200746ms","hash":1173842457,"current-db-size-bytes":56188928,"current-db-size":"56 MB","current-db-size-in-use-bytes":30896128,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:19:59.134852Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1173842457,"revision":12720,"compact-revision":10404} {"level":"info","ts":"2026-10-17T11:20:44.548858Z","caller":"traceutil/trace.go:171","msg":"trace[348981873] transaction","detail":"{read_only:false; response_revision:15563; number_of_response:1; }","duration":"114.328793ms","start":"2026-10-17T11:20:44.434499Z","end":"2026-10-17T11:20:44.548828Z","steps":["trace[348981873] 'process raft request' (duration: 114.1753ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:20:44.608804Z","caller":"traceutil/trace.go:171","msg":"trace[333406287] transaction","detail":"{read_only:false; response_revision:15564; number_of_response:1; }","duration":"114.615598ms","start":"2026-10-17T11:20:44.49416Z","end":"2026-10-17T11:20:44.608776Z","steps":["trace[333406287] 'process raft request' (duration: 114.461625ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:24:59.053583Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15299} {"level":"info","ts":"2026-10-17T11:24:59.168074Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15299,"took":"111.000262ms","hash":2844978260,"current-db-size-bytes":56188928,"current-db-size":"56 MB","current-db-size-in-use-bytes":31539200,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T11:24:59.168129Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2844978260,"revision":15299,"compact-revision":12720} {"level":"info","ts":"2026-10-17T11:26:16.524217Z","caller":"traceutil/trace.go:171","msg":"trace[1331958175] transaction","detail":"{read_only:false; response_revision:18040; number_of_response:1; }","duration":"127.040769ms","start":"2026-10-17T11:26:16.397152Z","end":"2026-10-17T11:26:16.524192Z","steps":["trace[1331958175] 'process raft request' (duration: 126.905407ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:26:19.774209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.964294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de8b1da0-f513-4732-a8d1-5721257dc5e3\" ","response":"range_response_count:1 size:3640"} {"level":"info","ts":"2026-10-17T11:26:19.774936Z","caller":"traceutil/trace.go:171","msg":"trace[1938564382] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-de8b1da0-f513-4732-a8d1-5721257dc5e3; range_end:; response_count:1; response_revision:18117; }","duration":"101.773738ms","start":"2026-10-17T11:26:19.673133Z","end":"2026-10-17T11:26:19.774907Z","steps":["trace[1938564382] 'range keys from in-memory index tree' (duration: 100.707919ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:28:43.726009Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:28:43.731867Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-17T11:28:43.73197Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-17T11:29:59.061462Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17462} {"level":"info","ts":"2026-10-17T11:29:59.175106Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17462,"took":"108.82769ms","hash":1444422479,"current-db-size-bytes":56188928,"current-db-size":"56 MB","current-db-size-in-use-bytes":33865728,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T11:29:59.175171Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1444422479,"revision":17462,"compact-revision":15299} {"level":"info","ts":"2026-10-17T11:31:57.357943Z","caller":"traceutil/trace.go:171","msg":"trace[478061968] transaction","detail":"{read_only:false; response_revision:20698; number_of_response:1; }","duration":"125.240797ms","start":"2026-10-17T11:31:57.23267Z","end":"2026-10-17T11:31:57.35791Z","steps":["trace[478061968] 'process raft request' (duration: 124.90523ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:58.164692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.236717ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-10-17T11:31:58.164816Z","caller":"traceutil/trace.go:171","msg":"trace[1215050604] linearizableReadLoop","detail":"{readStateIndex:21394; appliedIndex:21393; }","duration":"169.620894ms","start":"2026-10-17T11:31:57.995174Z","end":"2026-10-17T11:31:58.164795Z","steps":["trace[1215050604] 'read index received' (duration: 57.061µs)","trace[1215050604] 'applied index is now lower than readState.Index' (duration: 169.562223ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:31:58.164979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.802827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:31:58.165023Z","caller":"traceutil/trace.go:171","msg":"trace[2005362027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20698; }","duration":"169.894749ms","start":"2026-10-17T11:31:57.995115Z","end":"2026-10-17T11:31:58.16501Z","steps":["trace[2005362027] 'agreement among raft nodes before linearized reading' (duration: 169.804617ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:58.30708Z","caller":"traceutil/trace.go:171","msg":"trace[925594966] transaction","detail":"{read_only:false; response_revision:20699; number_of_response:1; }","duration":"104.950817ms","start":"2026-10-17T11:31:58.202097Z","end":"2026-10-17T11:31:58.307048Z","steps":["trace[925594966] 'process raft request' (duration: 104.766943ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:34:59.068615Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19859} {"level":"info","ts":"2026-10-17T11:34:59.203763Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19859,"took":"129.649471ms","hash":1633331247,"current-db-size-bytes":56188928,"current-db-size":"56 MB","current-db-size-in-use-bytes":30433280,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:34:59.203835Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1633331247,"revision":19859,"compact-revision":17462} {"level":"info","ts":"2026-10-17T11:35:54.513542Z","caller":"traceutil/trace.go:171","msg":"trace[1103049874] transaction","detail":"{read_only:false; response_revision:23160; number_of_response:1; }","duration":"142.259445ms","start":"2026-10-17T11:35:54.371258Z","end":"2026-10-17T11:35:54.513517Z","steps":["trace[1103049874] 'process raft request' (duration: 142.057451ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:35:54.818683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.251053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"} {"level":"warn","ts":"2026-10-17T11:35:54.818759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.763501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:35:54.818816Z","caller":"traceutil/trace.go:171","msg":"trace[1512784107] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:23160; }","duration":"136.474217ms","start":"2026-10-17T11:35:54.682308Z","end":"2026-10-17T11:35:54.818782Z","steps":["trace[1512784107] 'range keys from in-memory index tree' (duration: 135.879826ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:54.818893Z","caller":"traceutil/trace.go:171","msg":"trace[715616242] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:23160; }","duration":"220.959604ms","start":"2026-10-17T11:35:54.5979Z","end":"2026-10-17T11:35:54.818859Z","steps":["trace[715616242] 'range keys from in-memory index tree' (duration: 220.657338ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:54.831373Z","caller":"traceutil/trace.go:171","msg":"trace[1760755373] transaction","detail":"{read_only:false; response_revision:23161; number_of_response:1; }","duration":"112.903777ms","start":"2026-10-17T11:35:54.718415Z","end":"2026-10-17T11:35:54.831319Z","steps":["trace[1760755373] 'process raft request' (duration: 112.671503ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:22.485184Z","caller":"traceutil/trace.go:171","msg":"trace[1236640495] transaction","detail":"{read_only:false; response_revision:25196; number_of_response:1; }","duration":"313.36717ms","start":"2026-10-17T11:39:22.171776Z","end":"2026-10-17T11:39:22.485143Z","steps":["trace[1236640495] 'process raft request' (duration: 312.803819ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:39:22.485436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:39:22.171747Z","time spent":"313.549773ms","remote":"127.0.0.1:51548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:39:22.721532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.371478ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T11:39:22.721907Z","caller":"traceutil/trace.go:171","msg":"trace[742131614] transaction","detail":"{read_only:false; response_revision:25197; number_of_response:1; }","duration":"468.307663ms","start":"2026-10-17T11:39:22.253579Z","end":"2026-10-17T11:39:22.721886Z","steps":["trace[742131614] 'process raft request' (duration: 333.503576ms)","trace[742131614] 'compare' (duration: 133.948351ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:39:22.721982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:39:22.25355Z","time spent":"468.400534ms","remote":"127.0.0.1:51548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:39:22.722141Z","caller":"traceutil/trace.go:171","msg":"trace[1536240723] transaction","detail":"{read_only:false; response_revision:25198; number_of_response:1; }","duration":"466.748034ms","start":"2026-10-17T11:39:22.255383Z","end":"2026-10-17T11:39:22.722131Z","steps":["trace[1536240723] 'process raft request' (duration: 466.239034ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:39:22.7222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:39:22.255336Z","time spent":"466.834765ms","remote":"127.0.0.1:51548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:39:22.72233Z","caller":"traceutil/trace.go:171","msg":"trace[1253253671] transaction","detail":"{read_only:false; response_revision:25199; number_of_response:1; }","duration":"253.229768ms","start":"2026-10-17T11:39:22.469089Z","end":"2026-10-17T11:39:22.722319Z","steps":["trace[1253253671] 'process raft request' (duration: 252.590715ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:22.898931Z","caller":"traceutil/trace.go:171","msg":"trace[1583986045] transaction","detail":"{read_only:false; response_revision:25200; number_of_response:1; }","duration":"168.120049ms","start":"2026-10-17T11:39:22.730778Z","end":"2026-10-17T11:39:22.898899Z","steps":["trace[1583986045] 'process raft request' (duration: 158.925716ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:22.899038Z","caller":"traceutil/trace.go:171","msg":"trace[793382628] transaction","detail":"{read_only:false; response_revision:25201; number_of_response:1; }","duration":"145.273022ms","start":"2026-10-17T11:39:22.753743Z","end":"2026-10-17T11:39:22.899016Z","steps":["trace[793382628] 'process raft request' (duration: 145.078068ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:23.078406Z","caller":"traceutil/trace.go:171","msg":"trace[519548854] linearizableReadLoop","detail":"{readStateIndex:26025; appliedIndex:26024; }","duration":"173.094412ms","start":"2026-10-17T11:39:22.905282Z","end":"2026-10-17T11:39:23.078376Z","steps":["trace[519548854] 'read index received' (duration: 171.93254ms)","trace[519548854] 'applied index is now lower than readState.Index' (duration: 1.160902ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:39:23.078533Z","caller":"traceutil/trace.go:171","msg":"trace[776164876] transaction","detail":"{read_only:false; response_revision:25202; number_of_response:1; }","duration":"174.643691ms","start":"2026-10-17T11:39:22.903802Z","end":"2026-10-17T11:39:23.078446Z","steps":["trace[776164876] 'process raft request' (duration: 173.440268ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:39:23.078642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.332116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-17T11:39:23.07868Z","caller":"traceutil/trace.go:171","msg":"trace[1353001796] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:25202; }","duration":"173.410717ms","start":"2026-10-17T11:39:22.905257Z","end":"2026-10-17T11:39:23.078668Z","steps":["trace[1353001796] 'agreement among raft nodes before linearized reading' (duration: 173.239654ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:59.075334Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22120} {"level":"info","ts":"2026-10-17T11:39:59.198754Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22120,"took":"120.425238ms","hash":3830959887,"current-db-size-bytes":57876480,"current-db-size":"58 MB","current-db-size-in-use-bytes":44969984,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-17T11:39:59.198822Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3830959887,"revision":22120,"compact-revision":19859} {"level":"info","ts":"2026-10-17T11:40:24.826719Z","caller":"traceutil/trace.go:171","msg":"trace[2092772542] transaction","detail":"{read_only:false; response_revision:25786; number_of_response:1; }","duration":"108.061437ms","start":"2026-10-17T11:40:24.718631Z","end":"2026-10-17T11:40:24.826692Z","steps":["trace[2092772542] 'process raft request' (duration: 107.894354ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:25.328027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.518886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-17T11:40:25.328109Z","caller":"traceutil/trace.go:171","msg":"trace[655049611] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25789; }","duration":"108.650878ms","start":"2026-10-17T11:40:25.219439Z","end":"2026-10-17T11:40:25.328089Z","steps":["trace[655049611] 'range keys from in-memory index tree' (duration: 108.259931ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:25.5697Z","caller":"traceutil/trace.go:171","msg":"trace[844536882] transaction","detail":"{read_only:false; response_revision:25791; number_of_response:1; }","duration":"189.500136ms","start":"2026-10-17T11:40:25.380168Z","end":"2026-10-17T11:40:25.569668Z","steps":["trace[844536882] 'process raft request' (duration: 189.281512ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:25.569957Z","caller":"traceutil/trace.go:171","msg":"trace[338482374] linearizableReadLoop","detail":"{readStateIndex:26629; appliedIndex:26627; }","duration":"112.617992ms","start":"2026-10-17T11:40:25.457305Z","end":"2026-10-17T11:40:25.569923Z","steps":["trace[338482374] 'read index received' (duration: 112.040572ms)","trace[338482374] 'applied index is now lower than readState.Index' (duration: 574.5µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:25.569977Z","caller":"traceutil/trace.go:171","msg":"trace[721144497] transaction","detail":"{read_only:false; response_revision:25792; number_of_response:1; }","duration":"188.925386ms","start":"2026-10-17T11:40:25.381009Z","end":"2026-10-17T11:40:25.569935Z","steps":["trace[721144497] 'process raft request' (duration: 188.60033ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:25.570219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.904667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-17T11:40:25.570285Z","caller":"traceutil/trace.go:171","msg":"trace[385204749] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25792; }","duration":"113.025569ms","start":"2026-10-17T11:40:25.45724Z","end":"2026-10-17T11:40:25.570266Z","steps":["trace[385204749] 'agreement among raft nodes before linearized reading' (duration: 112.843386ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:55.122512Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068fd.wal"} {"level":"info","ts":"2026-10-17T11:44:41.277125Z","caller":"traceutil/trace.go:171","msg":"trace[2010314039] transaction","detail":"{read_only:false; response_revision:28280; number_of_response:1; }","duration":"126.501243ms","start":"2026-10-17T11:44:41.150595Z","end":"2026-10-17T11:44:41.277096Z","steps":["trace[2010314039] 'process raft request' (duration: 126.285579ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:44:59.082216Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25555} {"level":"info","ts":"2026-10-17T11:44:59.279074Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25555,"took":"192.886213ms","hash":822866626,"current-db-size-bytes":60252160,"current-db-size":"60 MB","current-db-size-in-use-bytes":35876864,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-17T11:44:59.279162Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":822866626,"revision":25555,"compact-revision":22120} {"level":"info","ts":"2026-10-17T11:46:22.558676Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:46:22.567397Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-17T11:46:22.567658Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-17T11:49:59.08987Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28429} {"level":"info","ts":"2026-10-17T11:49:59.240276Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28429,"took":"145.727433ms","hash":1516259860,"current-db-size-bytes":60252160,"current-db-size":"60 MB","current-db-size-in-use-bytes":30777344,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:49:59.240341Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1516259860,"revision":28429,"compact-revision":25555} {"level":"info","ts":"2026-10-17T11:54:59.097596Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30656} {"level":"info","ts":"2026-10-17T11:54:59.222379Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30656,"took":"120.814369ms","hash":1637777435,"current-db-size-bytes":60252160,"current-db-size":"60 MB","current-db-size-in-use-bytes":31096832,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:54:59.222519Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1637777435,"revision":30656,"compact-revision":28429} {"level":"info","ts":"2026-10-17T11:59:59.107294Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32915} {"level":"info","ts":"2026-10-17T11:59:59.280516Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32915,"took":"168.714895ms","hash":4241329151,"current-db-size-bytes":60252160,"current-db-size":"60 MB","current-db-size-in-use-bytes":30027776,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:59:59.280593Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4241329151,"revision":32915,"compact-revision":30656} {"level":"info","ts":"2026-10-17T12:04:59.116744Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35138} {"level":"info","ts":"2026-10-17T12:04:59.2521Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35138,"took":"129.675636ms","hash":1209108938,"current-db-size-bytes":60252160,"current-db-size":"60 MB","current-db-size-in-use-bytes":32288768,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:04:59.252153Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1209108938,"revision":35138,"compact-revision":32915} {"level":"info","ts":"2026-10-17T12:07:37.270972Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:07:37.279546Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-17T12:07:37.279639Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-17T12:09:59.125637Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37530} {"level":"info","ts":"2026-10-17T12:09:59.269195Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37530,"took":"138.056791ms","hash":2594751431,"current-db-size-bytes":60252160,"current-db-size":"60 MB","current-db-size-in-use-bytes":32780288,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T12:09:59.269269Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2594751431,"revision":37530,"compact-revision":35138} {"level":"info","ts":"2026-10-17T12:14:59.135709Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39839} {"level":"info","ts":"2026-10-17T12:14:59.276392Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39839,"took":"135.567076ms","hash":4195011283,"current-db-size-bytes":60252160,"current-db-size":"60 MB","current-db-size-in-use-bytes":30785536,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T12:14:59.276459Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4195011283,"revision":39839,"compact-revision":37530}