{"level":"warn","ts":"2026-07-29T00:48:43.444219Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-29T00:48:43.444355Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238: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://199.204.45.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238: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-07-29T00:48:43.444464Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-29T00:48:43.444513Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-07-29T00:48:43.444558Z","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-07-29T00:48:43.445578Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]} {"level":"info","ts":"2026-07-29T00:48:43.445679Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238: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-07-29T00:48:43.450483Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.461077ms"} {"level":"info","ts":"2026-07-29T00:48:43.457197Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-07-29T00:48:43.457285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-07-29T00:48:43.457312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-07-29T00:48:43.457323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-29T00:48:43.45734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-07-29T00:48:43.457376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-07-29T00:48:43.464955Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-29T00:48:43.466085Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-29T00:48:43.466914Z","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-07-29T00:48:43.468534Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-29T00:48:43.468713Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-29T00:48:43.468855Z","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-07-29T00:48:43.468936Z","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-07-29T00:48:43.469402Z","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-07-29T00:48:43.470221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-07-29T00:48:43.47038Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-07-29T00:48:43.471832Z","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-07-29T00:48:43.471882Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-07-29T00:48:43.471913Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-07-29T00:48:43.472743Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-29T00:48:43.472793Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-29T00:48:43.957812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-07-29T00:48:43.957897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-29T00:48:43.957929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-07-29T00:48:43.957949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-07-29T00:48:43.95797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-07-29T00:48:43.957991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-07-29T00:48:43.958009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-07-29T00:48:43.960843Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:48:43.961491Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"} {"level":"info","ts":"2026-07-29T00:48:43.961546Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T00:48:43.961914Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T00:48:43.962224Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-29T00:48:43.962256Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-29T00:48:43.962367Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:48:43.962474Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:48:43.962515Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:48:43.964263Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"info","ts":"2026-07-29T00:48:43.964611Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-29T00:49:20.250152Z","caller":"traceutil/trace.go:171","msg":"trace[692457410] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"220.53919ms","start":"2026-07-29T00:49:20.029571Z","end":"2026-07-29T00:49:20.250111Z","steps":["trace[692457410] 'process raft request' (duration: 131.203358ms)","trace[692457410] 'compare' (duration: 89.166578ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:49:20.260349Z","caller":"traceutil/trace.go:171","msg":"trace[1160040791] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"153.586394ms","start":"2026-07-29T00:49:20.10674Z","end":"2026-07-29T00:49:20.260326Z","steps":["trace[1160040791] 'process raft request' (duration: 153.479342ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:26.556077Z","caller":"traceutil/trace.go:171","msg":"trace[1599673346] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"246.721158ms","start":"2026-07-29T00:49:26.309332Z","end":"2026-07-29T00:49:26.556053Z","steps":["trace[1599673346] 'process raft request' (duration: 246.557644ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:26.812213Z","caller":"traceutil/trace.go:171","msg":"trace[559540680] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"109.824462ms","start":"2026-07-29T00:49:26.702359Z","end":"2026-07-29T00:49:26.812184Z","steps":["trace[559540680] 'read index received' (duration: 73.632822ms)","trace[559540680] 'applied index is now lower than readState.Index' (duration: 36.19056ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:49:26.812244Z","caller":"traceutil/trace.go:171","msg":"trace[1975835743] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"222.444785ms","start":"2026-07-29T00:49:26.589768Z","end":"2026-07-29T00:49:26.812212Z","steps":["trace[1975835743] 'process raft request' (duration: 186.187233ms)","trace[1975835743] 'compare' (duration: 36.009516ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:49:26.812443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.075759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-29T00:49:26.812551Z","caller":"traceutil/trace.go:171","msg":"trace[1082024656] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:642; }","duration":"110.188292ms","start":"2026-07-29T00:49:26.70234Z","end":"2026-07-29T00:49:26.812528Z","steps":["trace[1082024656] 'agreement among raft nodes before linearized reading' (duration: 109.947836ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:27.346655Z","caller":"traceutil/trace.go:171","msg":"trace[594650458] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"528.694924ms","start":"2026-07-29T00:49:26.817915Z","end":"2026-07-29T00:49:27.34661Z","steps":["trace[594650458] 'process raft request' (duration: 528.589732ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:27.346654Z","caller":"traceutil/trace.go:171","msg":"trace[1052212036] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"528.754766ms","start":"2026-07-29T00:49:26.817873Z","end":"2026-07-29T00:49:27.346628Z","steps":["trace[1052212036] 'process raft request' (duration: 502.273622ms)","trace[1052212036] 'compare' (duration: 26.208187ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:49:27.34666Z","caller":"traceutil/trace.go:171","msg":"trace[1043480992] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"528.622692ms","start":"2026-07-29T00:49:26.818014Z","end":"2026-07-29T00:49:27.346636Z","steps":["trace[1043480992] 'process raft request' (duration: 528.54252ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:27.346855Z","caller":"traceutil/trace.go:171","msg":"trace[1280759430] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"528.773436ms","start":"2026-07-29T00:49:26.818056Z","end":"2026-07-29T00:49:27.34683Z","steps":["trace[1280759430] 'process raft request' (duration: 528.54283ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:27.347628Z","caller":"traceutil/trace.go:171","msg":"trace[358664395] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:669; }","duration":"409.237766ms","start":"2026-07-29T00:49:26.938363Z","end":"2026-07-29T00:49:27.347601Z","steps":["trace[358664395] 'read index received' (duration: 381.798427ms)","trace[358664395] 'applied index is now lower than readState.Index' (duration: 27.438379ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:49:27.347752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:26.817906Z","time spent":"528.820157ms","remote":"127.0.0.1:45528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T00:49:27.34792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.533324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:49:27.34795Z","caller":"traceutil/trace.go:171","msg":"trace[1172671759] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"519.677863ms","start":"2026-07-29T00:49:26.828237Z","end":"2026-07-29T00:49:27.347915Z","steps":["trace[1172671759] 'process raft request' (duration: 519.109989ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:27.347987Z","caller":"traceutil/trace.go:171","msg":"trace[52756838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"409.656677ms","start":"2026-07-29T00:49:26.938318Z","end":"2026-07-29T00:49:27.347974Z","steps":["trace[52756838] 'agreement among raft nodes before linearized reading' (duration: 409.3834ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:49:27.348019Z","caller":"traceutil/trace.go:171","msg":"trace[1106408781] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"512.682623ms","start":"2026-07-29T00:49:26.835315Z","end":"2026-07-29T00:49:27.347998Z","steps":["trace[1106408781] 'process raft request' (duration: 512.229942ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:27.348028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:26.818008Z","time spent":"528.740205ms","remote":"127.0.0.1:45528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-29T00:49:27.348064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:26.938296Z","time spent":"409.757389ms","remote":"127.0.0.1:45452","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-07-29T00:49:27.348294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:26.828227Z","time spent":"519.798687ms","remote":"127.0.0.1:45480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:49:27.348399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:26.835298Z","time spent":"512.771925ms","remote":"127.0.0.1:45632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:49:27.348493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:26.818049Z","time spent":"528.837628ms","remote":"127.0.0.1:45694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:49:27.348625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:49:26.817856Z","time spent":"529.063744ms","remote":"127.0.0.1:45632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:49:42.080063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.352043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:49:42.080153Z","caller":"traceutil/trace.go:171","msg":"trace[819558799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"142.493306ms","start":"2026-07-29T00:49:41.937642Z","end":"2026-07-29T00:49:42.080136Z","steps":["trace[819558799] 'range keys from in-memory index tree' (duration: 142.24955ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:49:42.289532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.686506ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-29T00:49:42.289635Z","caller":"traceutil/trace.go:171","msg":"trace[1267324426] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"208.508839ms","start":"2026-07-29T00:49:42.081111Z","end":"2026-07-29T00:49:42.289619Z","steps":["trace[1267324426] 'read index received' (duration: 37.021µs)","trace[1267324426] 'applied index is now lower than readState.Index' (duration: 208.470628ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:49:42.289698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.583891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:49:42.289722Z","caller":"traceutil/trace.go:171","msg":"trace[162560415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"208.648642ms","start":"2026-07-29T00:49:42.081066Z","end":"2026-07-29T00:49:42.289715Z","steps":["trace[162560415] 'agreement among raft nodes before linearized reading' (duration: 208.591651ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:50:59.427955Z","caller":"traceutil/trace.go:171","msg":"trace[1768651641] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"121.271565ms","start":"2026-07-29T00:50:59.306658Z","end":"2026-07-29T00:50:59.42793Z","steps":["trace[1768651641] 'read index received' (duration: 121.083283ms)","trace[1768651641] 'applied index is now lower than readState.Index' (duration: 187.422µs)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:50:59.428189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.50347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-29T00:50:59.428233Z","caller":"traceutil/trace.go:171","msg":"trace[1015245096] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1886; }","duration":"121.580691ms","start":"2026-07-29T00:50:59.306639Z","end":"2026-07-29T00:50:59.42822Z","steps":["trace[1015245096] 'agreement among raft nodes before linearized reading' (duration: 121.398448ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:50:59.428286Z","caller":"traceutil/trace.go:171","msg":"trace[164770459] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"162.174494ms","start":"2026-07-29T00:50:59.26608Z","end":"2026-07-29T00:50:59.428254Z","steps":["trace[164770459] 'process raft request' (duration: 161.657407ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:51:32.095784Z","caller":"traceutil/trace.go:171","msg":"trace[71587867] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"164.817903ms","start":"2026-07-29T00:51:31.930944Z","end":"2026-07-29T00:51:32.095762Z","steps":["trace[71587867] 'process raft request' (duration: 164.674721ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:51:33.559307Z","caller":"traceutil/trace.go:171","msg":"trace[1808097212] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"108.51758ms","start":"2026-07-29T00:51:33.450768Z","end":"2026-07-29T00:51:33.559286Z","steps":["trace[1808097212] 'process raft request' (duration: 108.403517ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:52:29.98884Z","caller":"traceutil/trace.go:171","msg":"trace[1389642949] transaction","detail":"{read_only:false; response_revision:2530; number_of_response:1; }","duration":"151.83217ms","start":"2026-07-29T00:52:29.836983Z","end":"2026-07-29T00:52:29.988815Z","steps":["trace[1389642949] 'process raft request' (duration: 151.587627ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:53:02.627325Z","caller":"traceutil/trace.go:171","msg":"trace[1739827463] transaction","detail":"{read_only:false; response_revision:2710; number_of_response:1; }","duration":"127.619758ms","start":"2026-07-29T00:53:02.499666Z","end":"2026-07-29T00:53:02.627285Z","steps":["trace[1739827463] 'process raft request' (duration: 127.217994ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:37.520717Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976534051861817149,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T00:56:38.021545Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976534051861817149,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T00:56:38.522613Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976534051861817149,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T00:56:38.704951Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.68490281s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-29T00:56:38.71177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.691934441s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:56:38.711874Z","caller":"traceutil/trace.go:171","msg":"trace[1428338752] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:4422; }","duration":"1.692091293s","start":"2026-07-29T00:56:37.019767Z","end":"2026-07-29T00:56:38.711859Z","steps":["trace[1428338752] 'count revisions from in-memory index tree' (duration: 1.69188226s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.711929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.019755Z","time spent":"1.692164705s","remote":"127.0.0.1:45870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":29,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-07-29T00:56:38.7121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.692195316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:56:38.71216Z","caller":"traceutil/trace.go:171","msg":"trace[422979894] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:4422; }","duration":"1.692262557s","start":"2026-07-29T00:56:37.019888Z","end":"2026-07-29T00:56:38.712151Z","steps":["trace[422979894] 'count revisions from in-memory index tree' (duration: 1.692148564s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.712208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.019883Z","time spent":"1.692316028s","remote":"127.0.0.1:57600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-29T00:56:38.715194Z","caller":"traceutil/trace.go:171","msg":"trace[918088772] transaction","detail":"{read_only:false; response_revision:4423; number_of_response:1; }","duration":"1.695180661s","start":"2026-07-29T00:56:37.019991Z","end":"2026-07-29T00:56:38.715171Z","steps":["trace[918088772] 'process raft request' (duration: 1.685116084s)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:56:38.715285Z","caller":"traceutil/trace.go:171","msg":"trace[739176871] transaction","detail":"{read_only:false; response_revision:4424; number_of_response:1; }","duration":"1.691417772s","start":"2026-07-29T00:56:37.023829Z","end":"2026-07-29T00:56:38.715246Z","steps":["trace[739176871] 'process raft request' (duration: 1.691247228s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.7161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.023825Z","time spent":"1.692028613s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:56:38.715823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.019984Z","time spent":"1.695778512s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:56:38.715305Z","caller":"traceutil/trace.go:171","msg":"trace[2106489795] linearizableReadLoop","detail":"{readStateIndex:4596; appliedIndex:4589; }","duration":"1.69511548s","start":"2026-07-29T00:56:37.020172Z","end":"2026-07-29T00:56:38.715287Z","steps":["trace[2106489795] 'read index received' (duration: 1.684960052s)","trace[2106489795] 'applied index is now lower than readState.Index' (duration: 10.154658ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:56:38.715393Z","caller":"traceutil/trace.go:171","msg":"trace[309289115] transaction","detail":"{read_only:false; response_revision:4427; number_of_response:1; }","duration":"1.678069613s","start":"2026-07-29T00:56:37.03731Z","end":"2026-07-29T00:56:38.71538Z","steps":["trace[309289115] 'process raft request' (duration: 1.6779091s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.716564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.037302Z","time spent":"1.679209325s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T00:56:38.716719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.696459876s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8921d569-f9a3-439e-b332-55413c0b04e2\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-07-29T00:56:38.716792Z","caller":"traceutil/trace.go:171","msg":"trace[1845407538] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8921d569-f9a3-439e-b332-55413c0b04e2; range_end:; response_count:1; response_revision:4429; }","duration":"1.696538618s","start":"2026-07-29T00:56:37.020243Z","end":"2026-07-29T00:56:38.716782Z","steps":["trace[1845407538] 'agreement among raft nodes before linearized reading' (duration: 1.696418075s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.716821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.02024Z","time spent":"1.696572918s","remote":"127.0.0.1:45632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3798,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8921d569-f9a3-439e-b332-55413c0b04e2\" "} {"level":"warn","ts":"2026-07-29T00:56:38.716977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.497957736s","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-07-29T00:56:38.717001Z","caller":"traceutil/trace.go:171","msg":"trace[1369923576] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4429; }","duration":"1.498058777s","start":"2026-07-29T00:56:37.218937Z","end":"2026-07-29T00:56:38.716996Z","steps":["trace[1369923576] 'agreement among raft nodes before linearized reading' (duration: 1.497991876s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.717021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.218886Z","time spent":"1.498130679s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-29T00:56:38.717152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.683811359s","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-07-29T00:56:38.717175Z","caller":"traceutil/trace.go:171","msg":"trace[2115174264] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4429; }","duration":"1.683855441s","start":"2026-07-29T00:56:37.033315Z","end":"2026-07-29T00:56:38.71717Z","steps":["trace[2115174264] 'agreement among raft nodes before linearized reading' (duration: 1.683792349s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.717192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.033303Z","time spent":"1.683885521s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-29T00:56:38.71729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.693287686s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T00:56:38.71731Z","caller":"traceutil/trace.go:171","msg":"trace[765039103] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:4429; }","duration":"1.693314276s","start":"2026-07-29T00:56:37.02399Z","end":"2026-07-29T00:56:38.717304Z","steps":["trace[765039103] 'agreement among raft nodes before linearized reading' (duration: 1.693274885s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.717328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.023988Z","time spent":"1.693335286s","remote":"127.0.0.1:45900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-29T00:56:38.717435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.693479009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:56:38.717463Z","caller":"traceutil/trace.go:171","msg":"trace[582106757] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:4429; }","duration":"1.69351397s","start":"2026-07-29T00:56:37.023944Z","end":"2026-07-29T00:56:38.717458Z","steps":["trace[582106757] 'agreement among raft nodes before linearized reading' (duration: 1.693468709s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.717483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.023941Z","time spent":"1.69353614s","remote":"127.0.0.1:45710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-07-29T00:56:38.717588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.693709943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-29T00:56:38.717606Z","caller":"traceutil/trace.go:171","msg":"trace[17271545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4429; }","duration":"1.693737014s","start":"2026-07-29T00:56:37.023862Z","end":"2026-07-29T00:56:38.717599Z","steps":["trace[17271545] 'agreement among raft nodes before linearized reading' (duration: 1.693685333s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.717626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.023859Z","time spent":"1.693763215s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-29T00:56:38.717717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.693856707s","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-07-29T00:56:38.717743Z","caller":"traceutil/trace.go:171","msg":"trace[1198021816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4429; }","duration":"1.693887127s","start":"2026-07-29T00:56:37.02385Z","end":"2026-07-29T00:56:38.717737Z","steps":["trace[1198021816] 'agreement among raft nodes before linearized reading' (duration: 1.693828396s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.717765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.023847Z","time spent":"1.693913438s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-29T00:56:38.717842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.69402214s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:56:38.717864Z","caller":"traceutil/trace.go:171","msg":"trace[537336976] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4429; }","duration":"1.69405974s","start":"2026-07-29T00:56:37.023799Z","end":"2026-07-29T00:56:38.717859Z","steps":["trace[537336976] 'agreement among raft nodes before linearized reading' (duration: 1.694018129s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.717883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.023797Z","time spent":"1.694082301s","remote":"127.0.0.1:45452","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-07-29T00:56:38.717995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.4532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-29T00:56:38.718036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.038015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-07-29T00:56:38.71807Z","caller":"traceutil/trace.go:171","msg":"trace[1087550578] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:4429; }","duration":"133.125517ms","start":"2026-07-29T00:56:38.584937Z","end":"2026-07-29T00:56:38.718062Z","steps":["trace[1087550578] 'agreement among raft nodes before linearized reading' (duration: 133.017965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.718128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.27785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-29T00:56:38.718143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.343820862s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T00:56:38.715418Z","caller":"traceutil/trace.go:171","msg":"trace[1934243954] transaction","detail":"{read_only:false; response_revision:4425; number_of_response:1; }","duration":"1.691521383s","start":"2026-07-29T00:56:37.023891Z","end":"2026-07-29T00:56:38.715413Z","steps":["trace[1934243954] 'process raft request' (duration: 1.691269468s)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:56:38.718187Z","caller":"traceutil/trace.go:171","msg":"trace[1074002074] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:4429; }","duration":"233.319241ms","start":"2026-07-29T00:56:38.48484Z","end":"2026-07-29T00:56:38.718159Z","steps":["trace[1074002074] 'agreement among raft nodes before linearized reading' (duration: 233.26303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.718227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.023887Z","time spent":"1.694309384s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:56:38.718235Z","caller":"traceutil/trace.go:171","msg":"trace[739450359] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:4429; }","duration":"1.343929994s","start":"2026-07-29T00:56:37.37426Z","end":"2026-07-29T00:56:38.71819Z","steps":["trace[739450359] 'agreement among raft nodes before linearized reading' (duration: 1.343801902s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.718322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.374236Z","time spent":"1.344067907s","remote":"127.0.0.1:45642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":35,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-07-29T00:56:38.71544Z","caller":"traceutil/trace.go:171","msg":"trace[1799039023] transaction","detail":"{read_only:false; response_revision:4426; number_of_response:1; }","duration":"1.686448529s","start":"2026-07-29T00:56:37.028984Z","end":"2026-07-29T00:56:38.715433Z","steps":["trace[1799039023] 'process raft request' (duration: 1.686208465s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.718579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.028976Z","time spent":"1.689572707s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:56:38.718049Z","caller":"traceutil/trace.go:171","msg":"trace[925122501] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4429; }","duration":"472.546591ms","start":"2026-07-29T00:56:38.245491Z","end":"2026-07-29T00:56:38.718038Z","steps":["trace[925122501] 'agreement among raft nodes before linearized reading' (duration: 472.46931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.718774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:38.245469Z","time spent":"473.297067ms","remote":"127.0.0.1:45452","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-07-29T00:56:38.715454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.695264483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-29T00:56:38.718927Z","caller":"traceutil/trace.go:171","msg":"trace[1739150729] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:4429; }","duration":"1.698754508s","start":"2026-07-29T00:56:37.020163Z","end":"2026-07-29T00:56:38.718918Z","steps":["trace[1739150729] 'agreement among raft nodes before linearized reading' (duration: 1.695180811s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.718967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.02016Z","time spent":"1.698798479s","remote":"127.0.0.1:45480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.238\" "} {"level":"info","ts":"2026-07-29T00:56:38.715499Z","caller":"traceutil/trace.go:171","msg":"trace[1007634352] transaction","detail":"{read_only:false; response_revision:4428; number_of_response:1; }","duration":"1.599355336s","start":"2026-07-29T00:56:37.116136Z","end":"2026-07-29T00:56:38.715491Z","steps":["trace[1007634352] 'process raft request' (duration: 1.599108051s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.719155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.116109Z","time spent":"1.603019474s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:56:38.71552Z","caller":"traceutil/trace.go:171","msg":"trace[1827129881] transaction","detail":"{read_only:false; response_revision:4429; number_of_response:1; }","duration":"249.212337ms","start":"2026-07-29T00:56:38.466302Z","end":"2026-07-29T00:56:38.715514Z","steps":["trace[1827129881] 'process raft request' (duration: 248.961803ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.719539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.695767633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-29T00:56:38.719571Z","caller":"traceutil/trace.go:171","msg":"trace[1356801397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4429; }","duration":"1.695809323s","start":"2026-07-29T00:56:37.023754Z","end":"2026-07-29T00:56:38.719563Z","steps":["trace[1356801397] 'agreement among raft nodes before linearized reading' (duration: 1.695689731s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.719415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.376223217s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T00:56:38.71963Z","caller":"traceutil/trace.go:171","msg":"trace[49827059] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:4429; }","duration":"1.376515913s","start":"2026-07-29T00:56:37.343104Z","end":"2026-07-29T00:56:38.71962Z","steps":["trace[49827059] 'agreement among raft nodes before linearized reading' (duration: 1.376286219s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.719652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.69938178s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a234eeb7-eb83-434e-9d53-54b4df5b2b56\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-07-29T00:56:38.719747Z","caller":"traceutil/trace.go:171","msg":"trace[735932596] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a234eeb7-eb83-434e-9d53-54b4df5b2b56; range_end:; response_count:1; response_revision:4429; }","duration":"1.699465451s","start":"2026-07-29T00:56:37.02026Z","end":"2026-07-29T00:56:38.719726Z","steps":["trace[735932596] 'agreement among raft nodes before linearized reading' (duration: 1.699350559s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.719773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.020257Z","time spent":"1.699509942s","remote":"127.0.0.1:45632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3784,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a234eeb7-eb83-434e-9d53-54b4df5b2b56\" "} {"level":"warn","ts":"2026-07-29T00:56:38.719718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.343063Z","time spent":"1.376645136s","remote":"127.0.0.1:45752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":3,"response size":31,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-29T00:56:38.719591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.023748Z","time spent":"1.695838264s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-29T00:56:38.720866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.489165981s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-07-29T00:56:38.72568Z","caller":"traceutil/trace.go:171","msg":"trace[1826360269] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4429; }","duration":"1.493992852s","start":"2026-07-29T00:56:37.231671Z","end":"2026-07-29T00:56:38.725664Z","steps":["trace[1826360269] 'agreement among raft nodes before linearized reading' (duration: 1.485078196s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.725749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.231656Z","time spent":"1.494078973s","remote":"127.0.0.1:45554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2207442,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-07-29T00:56:38.72142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.697617007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T00:56:38.726007Z","caller":"traceutil/trace.go:171","msg":"trace[2058628651] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:4429; }","duration":"1.702207313s","start":"2026-07-29T00:56:37.023786Z","end":"2026-07-29T00:56:38.725993Z","steps":["trace[2058628651] 'agreement among raft nodes before linearized reading' (duration: 1.694186613s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:38.726042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:37.023784Z","time spent":"1.702247303s","remote":"127.0.0.1:45990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":40,"response size":31,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-07-29T00:56:54.248821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.469306ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-29T00:56:54.249387Z","caller":"traceutil/trace.go:171","msg":"trace[403804874] linearizableReadLoop","detail":"{readStateIndex:4885; appliedIndex:4884; }","duration":"133.755275ms","start":"2026-07-29T00:56:54.115518Z","end":"2026-07-29T00:56:54.249273Z","steps":["trace[403804874] 'read index received' (duration: 23.808621ms)","trace[403804874] 'applied index is now lower than readState.Index' (duration: 109.945514ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:56:54.249728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.232715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b1d82f74-d27b-419f-bebb-627489dfc326\" ","response":"range_response_count:1 size:3949"} {"level":"info","ts":"2026-07-29T00:56:54.249772Z","caller":"traceutil/trace.go:171","msg":"trace[2145613140] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b1d82f74-d27b-419f-bebb-627489dfc326; range_end:; response_count:1; response_revision:4709; }","duration":"134.332077ms","start":"2026-07-29T00:56:54.115426Z","end":"2026-07-29T00:56:54.249758Z","steps":["trace[2145613140] 'agreement among raft nodes before linearized reading' (duration: 134.135413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:57:08.093074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.857591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-07-29T00:57:08.093177Z","caller":"traceutil/trace.go:171","msg":"trace[48737732] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4866; }","duration":"152.018683ms","start":"2026-07-29T00:57:07.941136Z","end":"2026-07-29T00:57:08.093154Z","steps":["trace[48737732] 'range keys from in-memory index tree' (duration: 151.674847ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:57:08.093219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.652935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:57:08.09332Z","caller":"traceutil/trace.go:171","msg":"trace[1715019226] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4866; }","duration":"156.783818ms","start":"2026-07-29T00:57:07.93651Z","end":"2026-07-29T00:57:08.093294Z","steps":["trace[1715019226] 'range keys from in-memory index tree' (duration: 156.527513ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:57:40.301445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.586529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T00:57:40.301527Z","caller":"traceutil/trace.go:171","msg":"trace[311639750] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:5079; }","duration":"470.716831ms","start":"2026-07-29T00:57:39.830793Z","end":"2026-07-29T00:57:40.30151Z","steps":["trace[311639750] 'count revisions from in-memory index tree' (duration: 470.486028ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:57:40.301569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:57:39.830775Z","time spent":"470.782202ms","remote":"127.0.0.1:45554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":78,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-07-29T00:57:40.302248Z","caller":"traceutil/trace.go:171","msg":"trace[1957360732] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"359.942388ms","start":"2026-07-29T00:57:39.942294Z","end":"2026-07-29T00:57:40.302237Z","steps":["trace[1957360732] 'process raft request' (duration: 350.367925ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:57:40.302342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:57:39.942269Z","time spent":"360.019949ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:58:43.993439Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2929} {"level":"info","ts":"2026-07-29T00:58:44.153165Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2929,"took":"158.27201ms","hash":4126767973,"current-db-size-bytes":54874112,"current-db-size":"55 MB","current-db-size-in-use-bytes":29671424,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-29T00:58:44.153213Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4126767973,"revision":2929,"compact-revision":-1} {"level":"warn","ts":"2026-07-29T01:00:03.934125Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976534051861821133,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T01:00:04.434278Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976534051861821133,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T01:00:04.933011Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.658563911s","expected-duration":"1s"} {"level":"info","ts":"2026-07-29T01:00:04.933452Z","caller":"traceutil/trace.go:171","msg":"trace[1213515450] transaction","detail":"{read_only:false; response_revision:6053; number_of_response:1; }","duration":"1.659058589s","start":"2026-07-29T01:00:03.274338Z","end":"2026-07-29T01:00:04.933397Z","steps":["trace[1213515450] 'process raft request' (duration: 1.658865896s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:04.933676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.274313Z","time spent":"1.659224441s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:00:05.49945Z","caller":"traceutil/trace.go:171","msg":"trace[1985227761] linearizableReadLoop","detail":"{readStateIndex:6282; appliedIndex:6276; }","duration":"2.065718555s","start":"2026-07-29T01:00:03.433704Z","end":"2026-07-29T01:00:05.499422Z","steps":["trace[1985227761] 'read index received' (duration: 1.499546548s)","trace[1985227761] 'applied index is now lower than readState.Index' (duration: 566.170827ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T01:00:05.499832Z","caller":"traceutil/trace.go:171","msg":"trace[1558162513] transaction","detail":"{read_only:false; response_revision:6058; number_of_response:1; }","duration":"1.46502257s","start":"2026-07-29T01:00:04.03475Z","end":"2026-07-29T01:00:05.499772Z","steps":["trace[1558162513] 'process raft request' (duration: 1.464632994s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.500036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:04.034723Z","time spent":"1.465206432s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T01:00:05.500258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.066518408s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:05.500313Z","caller":"traceutil/trace.go:171","msg":"trace[1699831847] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:6058; }","duration":"2.066677081s","start":"2026-07-29T01:00:03.433619Z","end":"2026-07-29T01:00:05.500296Z","steps":["trace[1699831847] 'agreement among raft nodes before linearized reading' (duration: 2.066135982s)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:00:05.500332Z","caller":"traceutil/trace.go:171","msg":"trace[1021840621] transaction","detail":"{read_only:false; response_revision:6056; number_of_response:1; }","duration":"1.854871613s","start":"2026-07-29T01:00:03.64545Z","end":"2026-07-29T01:00:05.500321Z","steps":["trace[1021840621] 'process raft request' (duration: 1.853854178s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.500347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.965841965s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:05.500413Z","caller":"traceutil/trace.go:171","msg":"trace[297672326] transaction","detail":"{read_only:false; response_revision:6057; number_of_response:1; }","duration":"1.854636909s","start":"2026-07-29T01:00:03.64577Z","end":"2026-07-29T01:00:05.500407Z","steps":["trace[297672326] 'process raft request' (duration: 1.853569163s)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:00:05.50032Z","caller":"traceutil/trace.go:171","msg":"trace[676115747] transaction","detail":"{read_only:false; response_revision:6055; number_of_response:1; }","duration":"1.854822943s","start":"2026-07-29T01:00:03.645433Z","end":"2026-07-29T01:00:05.500256Z","steps":["trace[676115747] 'process raft request' (duration: 1.853835298s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.500498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.433589Z","time spent":"2.066892583s","remote":"127.0.0.1:53578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-07-29T01:00:05.500574Z","caller":"traceutil/trace.go:171","msg":"trace[1647690388] transaction","detail":"{read_only:false; response_revision:6054; number_of_response:1; }","duration":"1.909697879s","start":"2026-07-29T01:00:03.590868Z","end":"2026-07-29T01:00:05.500566Z","steps":["trace[1647690388] 'process raft request' (duration: 1.907627848s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.500587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.918545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-07-29T01:00:05.500619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.590837Z","time spent":"1.909757919s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:00:05.500619Z","caller":"traceutil/trace.go:171","msg":"trace[1532707913] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6058; }","duration":"591.997546ms","start":"2026-07-29T01:00:04.908612Z","end":"2026-07-29T01:00:05.500609Z","steps":["trace[1532707913] 'agreement among raft nodes before linearized reading' (duration: 591.856164ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.500624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.645398Z","time spent":"1.855103877s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T01:00:05.500655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:04.908575Z","time spent":"592.072237ms","remote":"127.0.0.1:45632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-07-29T01:00:05.500438Z","caller":"traceutil/trace.go:171","msg":"trace[2042112189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6058; }","duration":"1.965995046s","start":"2026-07-29T01:00:03.534418Z","end":"2026-07-29T01:00:05.500413Z","steps":["trace[2042112189] 'agreement among raft nodes before linearized reading' (duration: 1.965852854s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.500752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.534381Z","time spent":"1.966339962s","remote":"127.0.0.1:45452","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-07-29T01:00:05.500386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.645417Z","time spent":"1.854944245s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T01:00:05.500917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.700295919s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-29T01:00:05.500459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.645759Z","time spent":"1.854675801s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:00:05.500952Z","caller":"traceutil/trace.go:171","msg":"trace[1002579621] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6058; }","duration":"1.700348789s","start":"2026-07-29T01:00:03.800595Z","end":"2026-07-29T01:00:05.500944Z","steps":["trace[1002579621] 'agreement among raft nodes before linearized reading' (duration: 1.700209197s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.500975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.800586Z","time spent":"1.70038459s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-29T01:00:05.500922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.561800602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-29T01:00:05.501044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.708845961s","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-07-29T01:00:05.501039Z","caller":"traceutil/trace.go:171","msg":"trace[553521673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6058; }","duration":"1.561951104s","start":"2026-07-29T01:00:03.939058Z","end":"2026-07-29T01:00:05.501009Z","steps":["trace[553521673] 'agreement among raft nodes before linearized reading' (duration: 1.561789332s)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:00:05.501084Z","caller":"traceutil/trace.go:171","msg":"trace[2127267115] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6058; }","duration":"1.708936442s","start":"2026-07-29T01:00:03.792137Z","end":"2026-07-29T01:00:05.501073Z","steps":["trace[2127267115] 'agreement among raft nodes before linearized reading' (duration: 1.70879957s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.501066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.699321794s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-07-29T01:00:05.501102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.939042Z","time spent":"1.562047016s","remote":"127.0.0.1:45444","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-07-29T01:00:05.501156Z","caller":"traceutil/trace.go:171","msg":"trace[950776411] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6058; }","duration":"1.699442956s","start":"2026-07-29T01:00:03.80169Z","end":"2026-07-29T01:00:05.501133Z","steps":["trace[950776411] 'agreement among raft nodes before linearized reading' (duration: 1.699151432s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.501206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.801683Z","time spent":"1.699514307s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-29T01:00:05.500922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.703222204s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-29T01:00:05.50112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.792111Z","time spent":"1.708999453s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-29T01:00:05.501286Z","caller":"traceutil/trace.go:171","msg":"trace[1428349429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6058; }","duration":"1.703606729s","start":"2026-07-29T01:00:03.79767Z","end":"2026-07-29T01:00:05.501276Z","steps":["trace[1428349429] 'agreement among raft nodes before linearized reading' (duration: 1.703180793s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.50132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.797659Z","time spent":"1.70365269s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-29T01:00:05.50111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.700290069s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-29T01:00:05.501398Z","caller":"traceutil/trace.go:171","msg":"trace[2121110485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6058; }","duration":"1.700585703s","start":"2026-07-29T01:00:03.8008Z","end":"2026-07-29T01:00:05.501385Z","steps":["trace[2121110485] 'agreement among raft nodes before linearized reading' (duration: 1.700236198s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.501436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.800793Z","time spent":"1.700632804s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-29T01:00:40.529466Z","caller":"traceutil/trace.go:171","msg":"trace[1359414977] transaction","detail":"{read_only:false; response_revision:6397; number_of_response:1; }","duration":"213.467541ms","start":"2026-07-29T01:00:40.315963Z","end":"2026-07-29T01:00:40.52943Z","steps":["trace[1359414977] 'process raft request' (duration: 213.202577ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.559662Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.048745865s","expected-duration":"1s"} {"level":"info","ts":"2026-07-29T01:00:42.561207Z","caller":"traceutil/trace.go:171","msg":"trace[80245915] linearizableReadLoop","detail":"{readStateIndex:6633; appliedIndex:6631; }","duration":"2.184351161s","start":"2026-07-29T01:00:40.376822Z","end":"2026-07-29T01:00:42.561173Z","steps":["trace[80245915] 'read index received' (duration: 152.438492ms)","trace[80245915] 'applied index is now lower than readState.Index' (duration: 2.031911279s)"],"step_count":2} {"level":"info","ts":"2026-07-29T01:00:42.561212Z","caller":"traceutil/trace.go:171","msg":"trace[1675429260] transaction","detail":"{read_only:false; response_revision:6398; number_of_response:1; }","duration":"2.235784794s","start":"2026-07-29T01:00:40.325403Z","end":"2026-07-29T01:00:42.561188Z","steps":["trace[1675429260] 'process raft request' (duration: 2.234497205s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.561348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:40.325383Z","time spent":"2.235890455s","remote":"127.0.0.1:45632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6386,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T01:00:42.561363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.184530324s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T01:00:42.561442Z","caller":"traceutil/trace.go:171","msg":"trace[217358236] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:6398; }","duration":"2.184683776s","start":"2026-07-29T01:00:40.376737Z","end":"2026-07-29T01:00:42.561421Z","steps":["trace[217358236] 'agreement among raft nodes before linearized reading' (duration: 2.184534513s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.561483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:40.376704Z","time spent":"2.184769497s","remote":"127.0.0.1:45886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-07-29T01:00:42.563675Z","caller":"traceutil/trace.go:171","msg":"trace[311800134] transaction","detail":"{read_only:false; response_revision:6399; number_of_response:1; }","duration":"939.448158ms","start":"2026-07-29T01:00:41.624198Z","end":"2026-07-29T01:00:42.563646Z","steps":["trace[311800134] 'process raft request' (duration: 939.193294ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.563783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.62418Z","time spent":"939.54831ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:00:42.56397Z","caller":"traceutil/trace.go:171","msg":"trace[547044826] transaction","detail":"{read_only:false; response_revision:6400; number_of_response:1; }","duration":"922.577011ms","start":"2026-07-29T01:00:41.641382Z","end":"2026-07-29T01:00:42.563959Z","steps":["trace[547044826] 'process raft request' (duration: 922.143284ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.564034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.641376Z","time spent":"922.625641ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:00:42.564312Z","caller":"traceutil/trace.go:171","msg":"trace[428737922] transaction","detail":"{read_only:false; response_revision:6401; number_of_response:1; }","duration":"888.608514ms","start":"2026-07-29T01:00:41.675689Z","end":"2026-07-29T01:00:42.564298Z","steps":["trace[428737922] 'process raft request' (duration: 887.879473ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.564391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.675596Z","time spent":"888.756466ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:00:42.565553Z","caller":"traceutil/trace.go:171","msg":"trace[1175533787] transaction","detail":"{read_only:false; response_revision:6402; number_of_response:1; }","duration":"889.667601ms","start":"2026-07-29T01:00:41.675868Z","end":"2026-07-29T01:00:42.565536Z","steps":["trace[1175533787] 'process raft request' (duration: 887.735791ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.565658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.67586Z","time spent":"889.737492ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T01:00:42.567608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.304714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:42.567737Z","caller":"traceutil/trace.go:171","msg":"trace[1897674846] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:6402; }","duration":"297.502967ms","start":"2026-07-29T01:00:42.270207Z","end":"2026-07-29T01:00:42.56771Z","steps":["trace[1897674846] 'agreement among raft nodes before linearized reading' (duration: 297.309685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.567752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.332882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-29T01:00:42.567785Z","caller":"traceutil/trace.go:171","msg":"trace[1977275484] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6402; }","duration":"852.384642ms","start":"2026-07-29T01:00:41.715391Z","end":"2026-07-29T01:00:42.567775Z","steps":["trace[1977275484] 'agreement among raft nodes before linearized reading' (duration: 852.274551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.567811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.715381Z","time spent":"852.425293ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-29T01:00:42.567838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.287141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T01:00:42.56787Z","caller":"traceutil/trace.go:171","msg":"trace[821610985] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6402; }","duration":"536.362522ms","start":"2026-07-29T01:00:42.031497Z","end":"2026-07-29T01:00:42.56786Z","steps":["trace[821610985] 'agreement among raft nodes before linearized reading' (duration: 536.296821ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.567891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:42.031455Z","time spent":"536.430743ms","remote":"127.0.0.1:60724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-07-29T01:00:42.568025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.421507215s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T01:00:42.568046Z","caller":"traceutil/trace.go:171","msg":"trace[1163669872] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:6402; }","duration":"1.421539686s","start":"2026-07-29T01:00:41.146501Z","end":"2026-07-29T01:00:42.56804Z","steps":["trace[1163669872] 'agreement among raft nodes before linearized reading' (duration: 1.421447935s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.568065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.146496Z","time spent":"1.421564467s","remote":"127.0.0.1:45554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":80,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-07-29T01:00:42.56811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.456804ms","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-07-29T01:00:42.568132Z","caller":"traceutil/trace.go:171","msg":"trace[338884879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6402; }","duration":"858.522985ms","start":"2026-07-29T01:00:41.709602Z","end":"2026-07-29T01:00:42.568125Z","steps":["trace[338884879] 'agreement among raft nodes before linearized reading' (duration: 858.448014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.568156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.709582Z","time spent":"858.569366ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-29T01:00:42.568203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.265893297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-07-29T01:00:42.568229Z","caller":"traceutil/trace.go:171","msg":"trace[74889946] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6402; }","duration":"1.265946797s","start":"2026-07-29T01:00:41.302276Z","end":"2026-07-29T01:00:42.568223Z","steps":["trace[74889946] 'agreement among raft nodes before linearized reading' (duration: 1.265875356s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.568233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.790344ms","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-07-29T01:00:42.568276Z","caller":"traceutil/trace.go:171","msg":"trace[1866678843] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6402; }","duration":"874.848726ms","start":"2026-07-29T01:00:41.693417Z","end":"2026-07-29T01:00:42.568265Z","steps":["trace[1866678843] 'agreement among raft nodes before linearized reading' (duration: 874.689642ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.568317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.69341Z","time spent":"874.897446ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-29T01:00:42.568353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.465293974s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:42.568377Z","caller":"traceutil/trace.go:171","msg":"trace[160477887] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:0; response_revision:6402; }","duration":"1.465341374s","start":"2026-07-29T01:00:41.103029Z","end":"2026-07-29T01:00:42.56837Z","steps":["trace[160477887] 'agreement among raft nodes before linearized reading' (duration: 1.465306204s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.568395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.103016Z","time spent":"1.465374714s","remote":"127.0.0.1:45694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-07-29T01:00:42.568248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.30226Z","time spent":"1.265983507s","remote":"127.0.0.1:45632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-29T01:00:42.567762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.568046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-29T01:00:42.568665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"868.579609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-29T01:00:42.568671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.561153072s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:42.568698Z","caller":"traceutil/trace.go:171","msg":"trace[829342003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6402; }","duration":"868.64532ms","start":"2026-07-29T01:00:41.700045Z","end":"2026-07-29T01:00:42.56869Z","steps":["trace[829342003] 'agreement among raft nodes before linearized reading' (duration: 868.240544ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:00:42.568699Z","caller":"traceutil/trace.go:171","msg":"trace[1719614404] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:0; response_revision:6402; }","duration":"1.561207073s","start":"2026-07-29T01:00:41.007485Z","end":"2026-07-29T01:00:42.568692Z","steps":["trace[1719614404] 'agreement among raft nodes before linearized reading' (duration: 1.561161382s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.568718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.700029Z","time spent":"868.68444ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-29T01:00:42.568721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.007461Z","time spent":"1.561255734s","remote":"127.0.0.1:45694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-07-29T01:00:42.56746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.59324028s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:42.568837Z","caller":"traceutil/trace.go:171","msg":"trace[1032925045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6402; }","duration":"1.594656113s","start":"2026-07-29T01:00:40.974169Z","end":"2026-07-29T01:00:42.568825Z","steps":["trace[1032925045] 'agreement among raft nodes before linearized reading' (duration: 1.593249901s)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:00:42.568739Z","caller":"traceutil/trace.go:171","msg":"trace[1442503862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6402; }","duration":"859.45199ms","start":"2026-07-29T01:00:41.709119Z","end":"2026-07-29T01:00:42.568571Z","steps":["trace[1442503862] 'agreement among raft nodes before linearized reading' (duration: 858.325602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.568549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.426950179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:42.569282Z","caller":"traceutil/trace.go:171","msg":"trace[739170163] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:0; response_revision:6402; }","duration":"1.427738351s","start":"2026-07-29T01:00:41.141533Z","end":"2026-07-29T01:00:42.569271Z","steps":["trace[739170163] 'agreement among raft nodes before linearized reading' (duration: 1.4269513s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.569331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.141526Z","time spent":"1.427776032s","remote":"127.0.0.1:45694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-07-29T01:00:42.568896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:40.974149Z","time spent":"1.594740024s","remote":"127.0.0.1:45452","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-07-29T01:00:42.569525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.709113Z","time spent":"860.176531ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-29T01:00:45.901929Z","caller":"traceutil/trace.go:171","msg":"trace[690870513] transaction","detail":"{read_only:false; response_revision:6424; number_of_response:1; }","duration":"134.139999ms","start":"2026-07-29T01:00:45.767757Z","end":"2026-07-29T01:00:45.901897Z","steps":["trace[690870513] 'process raft request' (duration: 133.886284ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:02:49.671614Z","caller":"traceutil/trace.go:171","msg":"trace[165941216] transaction","detail":"{read_only:false; response_revision:7153; number_of_response:1; }","duration":"555.19996ms","start":"2026-07-29T01:02:49.116388Z","end":"2026-07-29T01:02:49.671588Z","steps":["trace[165941216] 'process raft request' (duration: 554.988054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.671834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.116369Z","time spent":"555.345474ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:02:49.673318Z","caller":"traceutil/trace.go:171","msg":"trace[219821281] transaction","detail":"{read_only:false; response_revision:7154; number_of_response:1; }","duration":"555.716537ms","start":"2026-07-29T01:02:49.117576Z","end":"2026-07-29T01:02:49.673293Z","steps":["trace[219821281] 'process raft request' (duration: 555.540631ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:02:49.67353Z","caller":"traceutil/trace.go:171","msg":"trace[1440084573] linearizableReadLoop","detail":"{readStateIndex:7420; appliedIndex:7417; }","duration":"378.115502ms","start":"2026-07-29T01:02:49.295396Z","end":"2026-07-29T01:02:49.673512Z","steps":["trace[1440084573] 'read index received' (duration: 376.019969ms)","trace[1440084573] 'applied index is now lower than readState.Index' (duration: 2.094583ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T01:02:49.673599Z","caller":"traceutil/trace.go:171","msg":"trace[566303544] transaction","detail":"{read_only:false; response_revision:7155; number_of_response:1; }","duration":"548.483181ms","start":"2026-07-29T01:02:49.125084Z","end":"2026-07-29T01:02:49.673568Z","steps":["trace[566303544] 'process raft request' (duration: 548.158881ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.673766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.087095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-07-29T01:02:49.673764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.125063Z","time spent":"548.608344ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:02:49.673804Z","caller":"traceutil/trace.go:171","msg":"trace[456897424] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7155; }","duration":"354.147417ms","start":"2026-07-29T01:02:49.319649Z","end":"2026-07-29T01:02:49.673797Z","steps":["trace[456897424] 'agreement among raft nodes before linearized reading' (duration: 353.994213ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.673824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.319639Z","time spent":"354.180258ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-29T01:02:49.673825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.673414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-07-29T01:02:49.673847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.459377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-29T01:02:49.673904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.88952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-29T01:02:49.673901Z","caller":"traceutil/trace.go:171","msg":"trace[1842898574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7155; }","duration":"347.53971ms","start":"2026-07-29T01:02:49.326349Z","end":"2026-07-29T01:02:49.673888Z","steps":["trace[1842898574] 'agreement among raft nodes before linearized reading' (duration: 347.371895ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:02:49.673923Z","caller":"traceutil/trace.go:171","msg":"trace[1430155914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7155; }","duration":"347.958992ms","start":"2026-07-29T01:02:49.325959Z","end":"2026-07-29T01:02:49.673918Z","steps":["trace[1430155914] 'agreement among raft nodes before linearized reading' (duration: 347.912401ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.67394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.325939Z","time spent":"347.998504ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-29T01:02:49.673939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.326298Z","time spent":"347.632982ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-29T01:02:49.673896Z","caller":"traceutil/trace.go:171","msg":"trace[1556551059] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7155; }","duration":"344.786408ms","start":"2026-07-29T01:02:49.329095Z","end":"2026-07-29T01:02:49.673881Z","steps":["trace[1556551059] 'agreement among raft nodes before linearized reading' (duration: 344.546981ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.673979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.32908Z","time spent":"344.895321ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-29T01:02:49.674324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.913245ms","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-07-29T01:02:49.674364Z","caller":"traceutil/trace.go:171","msg":"trace[1007870020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7155; }","duration":"379.002688ms","start":"2026-07-29T01:02:49.295351Z","end":"2026-07-29T01:02:49.674354Z","steps":["trace[1007870020] 'agreement among raft nodes before linearized reading' (duration: 378.228035ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.674392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.295333Z","time spent":"379.052539ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-29T01:02:49.676283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.117556Z","time spent":"555.876711ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:03:43.998537Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5645} {"level":"info","ts":"2026-07-29T01:03:44.094845Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5645,"took":"95.071609ms","hash":3309726804,"current-db-size-bytes":54874112,"current-db-size":"55 MB","current-db-size-in-use-bytes":18300928,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-29T01:03:44.094897Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3309726804,"revision":5645,"compact-revision":2929} {"level":"info","ts":"2026-07-29T01:04:12.456254Z","caller":"traceutil/trace.go:171","msg":"trace[1762897961] transaction","detail":"{read_only:false; response_revision:7570; number_of_response:1; }","duration":"449.273226ms","start":"2026-07-29T01:04:12.006959Z","end":"2026-07-29T01:04:12.456232Z","steps":["trace[1762897961] 'process raft request' (duration: 449.114381ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:04:12.456581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.00694Z","time spent":"449.42409ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:04:12.519726Z","caller":"traceutil/trace.go:171","msg":"trace[281185536] transaction","detail":"{read_only:false; response_revision:7571; number_of_response:1; }","duration":"512.497887ms","start":"2026-07-29T01:04:12.007212Z","end":"2026-07-29T01:04:12.51971Z","steps":["trace[281185536] 'process raft request' (duration: 512.332812ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:04:12.519823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.007203Z","time spent":"512.570508ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:04:12.519931Z","caller":"traceutil/trace.go:171","msg":"trace[86829079] transaction","detail":"{read_only:false; response_revision:7572; number_of_response:1; }","duration":"511.525881ms","start":"2026-07-29T01:04:12.008365Z","end":"2026-07-29T01:04:12.519891Z","steps":["trace[86829079] 'process raft request' (duration: 511.308886ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:04:12.519945Z","caller":"traceutil/trace.go:171","msg":"trace[2091700859] linearizableReadLoop","detail":"{readStateIndex:7854; appliedIndex:7851; }","duration":"507.208178ms","start":"2026-07-29T01:04:12.012708Z","end":"2026-07-29T01:04:12.519916Z","steps":["trace[2091700859] 'read index received' (duration: 443.433713ms)","trace[2091700859] 'applied index is now lower than readState.Index' (duration: 63.771755ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T01:04:12.5201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.00836Z","time spent":"511.652864ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T01:04:12.520348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.625298ms","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-07-29T01:04:12.520488Z","caller":"traceutil/trace.go:171","msg":"trace[1622594511] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7572; }","duration":"507.806833ms","start":"2026-07-29T01:04:12.012656Z","end":"2026-07-29T01:04:12.520463Z","steps":["trace[1622594511] 'agreement among raft nodes before linearized reading' (duration: 507.30963ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:04:12.520598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.012641Z","time spent":"507.945236ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-29T01:04:12.521864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.605815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:04:12.52192Z","caller":"traceutil/trace.go:171","msg":"trace[130913063] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:7572; }","duration":"508.687566ms","start":"2026-07-29T01:04:12.013217Z","end":"2026-07-29T01:04:12.521904Z","steps":["trace[130913063] 'agreement among raft nodes before linearized reading' (duration: 508.608284ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:04:12.521958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.013205Z","time spent":"508.744698ms","remote":"127.0.0.1:45576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-07-29T01:04:12.522022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.458502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-osds-overview\" ","response":"range_response_count:1 size:38898"} {"level":"warn","ts":"2026-07-29T01:04:12.522098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.993221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-29T01:04:12.522079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.048483ms","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-07-29T01:04:12.522135Z","caller":"traceutil/trace.go:171","msg":"trace[962353265] range","detail":"{range_begin:/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-osds-overview; range_end:; response_count:1; response_revision:7572; }","duration":"457.595765ms","start":"2026-07-29T01:04:12.064511Z","end":"2026-07-29T01:04:12.522107Z","steps":["trace[962353265] 'agreement among raft nodes before linearized reading' (duration: 457.36605ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:04:12.522158Z","caller":"traceutil/trace.go:171","msg":"trace[1514533240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7572; }","duration":"494.161335ms","start":"2026-07-29T01:04:12.027982Z","end":"2026-07-29T01:04:12.522144Z","steps":["trace[1514533240] 'agreement among raft nodes before linearized reading' (duration: 493.869228ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:04:12.522178Z","caller":"traceutil/trace.go:171","msg":"trace[1582713647] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7572; }","duration":"494.173336ms","start":"2026-07-29T01:04:12.027982Z","end":"2026-07-29T01:04:12.522156Z","steps":["trace[1582713647] 'agreement among raft nodes before linearized reading' (duration: 493.93594ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:04:12.522222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.027972Z","time spent":"494.241147ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-29T01:04:12.522225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.597364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-29T01:04:12.52218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.064492Z","time spent":"457.675997ms","remote":"127.0.0.1:45554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":38922,"request content":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-osds-overview\" "} {"level":"warn","ts":"2026-07-29T01:04:12.522266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.302391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-29T01:04:12.522276Z","caller":"traceutil/trace.go:171","msg":"trace[1460648535] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7572; }","duration":"508.664006ms","start":"2026-07-29T01:04:12.0136Z","end":"2026-07-29T01:04:12.522264Z","steps":["trace[1460648535] 'agreement among raft nodes before linearized reading' (duration: 508.531152ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:04:12.52234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.013594Z","time spent":"508.738518ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-29T01:04:12.52234Z","caller":"traceutil/trace.go:171","msg":"trace[1148693058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7572; }","duration":"496.412714ms","start":"2026-07-29T01:04:12.025911Z","end":"2026-07-29T01:04:12.522323Z","steps":["trace[1148693058] 'agreement among raft nodes before linearized reading' (duration: 496.24494ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:04:12.522379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.025893Z","time spent":"496.477995ms","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-29T01:04:12.522245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.027974Z","time spent":"494.223667ms","remote":"127.0.0.1:45732","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":"warn","ts":"2026-07-29T01:04:12.522588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.45048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-pool-detail\" ","response":"range_response_count:1 size:20067"} {"level":"info","ts":"2026-07-29T01:04:12.52264Z","caller":"traceutil/trace.go:171","msg":"trace[1951677552] range","detail":"{range_begin:/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-pool-detail; range_end:; response_count:1; response_revision:7572; }","duration":"508.528972ms","start":"2026-07-29T01:04:12.014098Z","end":"2026-07-29T01:04:12.522627Z","steps":["trace[1951677552] 'agreement among raft nodes before linearized reading' (duration: 508.011759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:04:12.522716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:04:12.014086Z","time spent":"508.584364ms","remote":"127.0.0.1:45554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":20091,"request content":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-pool-detail\" "}