{"level":"warn","ts":"2026-09-21T03:00:21.706485Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-21T03:00:21.706622Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.196:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.196:2380","--initial-cluster=instance=https://162.253.55.196:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.196:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.196:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-21T03:00:21.706719Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-21T03:00:21.706737Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.196:2380"]} {"level":"info","ts":"2026-09-21T03:00:21.706768Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-21T03:00:21.707675Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.196:2379"]} {"level":"info","ts":"2026-09-21T03:00:21.707782Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.196:2380"],"listen-peer-urls":["https://162.253.55.196:2380"],"advertise-client-urls":["https://162.253.55.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.196:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-21T03:00:21.720518Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"12.456625ms"} {"level":"info","ts":"2026-09-21T03:00:21.731495Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"40c23df05199fc95","cluster-id":"a4d434936ffe8e8"} {"level":"info","ts":"2026-09-21T03:00:21.731638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 switched to configuration voters=()"} {"level":"info","ts":"2026-09-21T03:00:21.731741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became follower at term 0"} {"level":"info","ts":"2026-09-21T03:00:21.731787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 40c23df05199fc95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-21T03:00:21.731837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became follower at term 1"} {"level":"info","ts":"2026-09-21T03:00:21.73197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 switched to configuration voters=(4666360266279746709)"} {"level":"warn","ts":"2026-09-21T03:00:21.736924Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-21T03:00:21.738332Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-21T03:00:21.739334Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-21T03:00:21.742256Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"40c23df05199fc95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-21T03:00:21.746529Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"40c23df05199fc95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-21T03:00:21.746779Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-21T03:00:21.74692Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-21T03:00:21.746932Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-21T03:00:21.747217Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.196:2380"} {"level":"info","ts":"2026-09-21T03:00:21.74728Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.196:2380"} {"level":"info","ts":"2026-09-21T03:00:21.746767Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-21T03:00:21.747744Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"40c23df05199fc95","initial-advertise-peer-urls":["https://162.253.55.196:2380"],"listen-peer-urls":["https://162.253.55.196:2380"],"advertise-client-urls":["https://162.253.55.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-21T03:00:21.747854Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-21T03:00:21.748071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 switched to configuration voters=(4666360266279746709)"} {"level":"info","ts":"2026-09-21T03:00:21.748347Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a4d434936ffe8e8","local-member-id":"40c23df05199fc95","added-peer-id":"40c23df05199fc95","added-peer-peer-urls":["https://162.253.55.196:2380"]} {"level":"info","ts":"2026-09-21T03:00:22.132726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 is starting a new election at term 1"} {"level":"info","ts":"2026-09-21T03:00:22.132791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-21T03:00:22.132823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 received MsgPreVoteResp from 40c23df05199fc95 at term 1"} {"level":"info","ts":"2026-09-21T03:00:22.132848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became candidate at term 2"} {"level":"info","ts":"2026-09-21T03:00:22.132857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 received MsgVoteResp from 40c23df05199fc95 at term 2"} {"level":"info","ts":"2026-09-21T03:00:22.132873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became leader at term 2"} {"level":"info","ts":"2026-09-21T03:00:22.132886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 40c23df05199fc95 elected leader 40c23df05199fc95 at term 2"} {"level":"info","ts":"2026-09-21T03:00:22.134903Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"40c23df05199fc95","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.196:2379]}","request-path":"/0/members/40c23df05199fc95/attributes","cluster-id":"a4d434936ffe8e8","publish-timeout":"7s"} {"level":"info","ts":"2026-09-21T03:00:22.135056Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-21T03:00:22.13538Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-21T03:00:22.136941Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a4d434936ffe8e8","local-member-id":"40c23df05199fc95","cluster-version":"3.5"} {"level":"info","ts":"2026-09-21T03:00:22.137189Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-21T03:00:22.137332Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-21T03:00:22.137766Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-21T03:00:22.137931Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-21T03:00:22.138022Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-21T03:00:22.138597Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-21T03:00:22.144312Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.196:2379"} {"level":"warn","ts":"2026-09-21T03:00:25.843214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.89554ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-21T03:00:25.843398Z","caller":"traceutil/trace.go:171","msg":"trace[374395089] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"222.598074ms","start":"2026-09-21T03:00:25.620746Z","end":"2026-09-21T03:00:25.843344Z","steps":["trace[374395089] 'process raft request' (duration: 59.835999ms)","trace[374395089] 'compare' (duration: 161.701709ms)"],"step_count":2} {"level":"warn","ts":"2026-09-21T03:00:26.130367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.395178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-21T03:00:26.130569Z","caller":"traceutil/trace.go:171","msg":"trace[1247464122] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"281.19006ms","start":"2026-09-21T03:00:25.849352Z","end":"2026-09-21T03:00:26.130542Z","steps":["trace[1247464122] 'process raft request' (duration: 151.52164ms)","trace[1247464122] 'compare' (duration: 129.21208ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:00:26.131926Z","caller":"traceutil/trace.go:171","msg":"trace[1738380267] transaction","detail":"{read_only:false; response_revision:176; number_of_response:1; }","duration":"183.203654ms","start":"2026-09-21T03:00:25.948705Z","end":"2026-09-21T03:00:26.131908Z","steps":["trace[1738380267] 'process raft request' (duration: 182.816289ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:01:03.677792Z","caller":"traceutil/trace.go:171","msg":"trace[710748932] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:569; }","duration":"118.285944ms","start":"2026-09-21T03:01:03.559493Z","end":"2026-09-21T03:01:03.677779Z","steps":["trace[710748932] 'read index received' (duration: 118.210711ms)","trace[710748932] 'applied index is now lower than readState.Index' (duration: 74.673µs)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:01:03.67788Z","caller":"traceutil/trace.go:171","msg":"trace[117175735] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"137.3905ms","start":"2026-09-21T03:01:03.540455Z","end":"2026-09-21T03:01:03.677846Z","steps":["trace[117175735] 'process raft request' (duration: 137.176064ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:01:03.678012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.51062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:150495"} {"level":"info","ts":"2026-09-21T03:01:03.678036Z","caller":"traceutil/trace.go:171","msg":"trace[683262661] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:547; }","duration":"118.577432ms","start":"2026-09-21T03:01:03.559452Z","end":"2026-09-21T03:01:03.678029Z","steps":["trace[683262661] 'agreement among raft nodes before linearized reading' (duration: 118.430518ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:01:04.010955Z","caller":"traceutil/trace.go:171","msg":"trace[1396931017] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"333.060676ms","start":"2026-09-21T03:01:03.677867Z","end":"2026-09-21T03:01:04.010928Z","steps":["trace[1396931017] 'read index received' (duration: 277.898096ms)","trace[1396931017] 'applied index is now lower than readState.Index' (duration: 55.16147ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:01:04.011395Z","caller":"traceutil/trace.go:171","msg":"trace[1536449108] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"445.792731ms","start":"2026-09-21T03:01:03.565576Z","end":"2026-09-21T03:01:04.011369Z","steps":["trace[1536449108] 'process raft request' (duration: 390.386323ms)","trace[1536449108] 'compare' (duration: 54.74471ms)"],"step_count":2} {"level":"warn","ts":"2026-09-21T03:01:04.011517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:01:03.565556Z","time spent":"445.890563ms","remote":"127.0.0.1:60494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-21T03:01:04.011636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.183851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-21T03:01:04.011676Z","caller":"traceutil/trace.go:171","msg":"trace[531682233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:548; }","duration":"340.255672ms","start":"2026-09-21T03:01:03.67141Z","end":"2026-09-21T03:01:04.011666Z","steps":["trace[531682233] 'agreement among raft nodes before linearized reading' (duration: 340.084927ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:01:04.011703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:01:03.671398Z","time spent":"340.298314ms","remote":"127.0.0.1:60754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-21T03:01:04.098026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.121186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-21T03:01:04.098104Z","caller":"traceutil/trace.go:171","msg":"trace[948959325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:549; }","duration":"251.244ms","start":"2026-09-21T03:01:03.846843Z","end":"2026-09-21T03:01:04.098087Z","steps":["trace[948959325] 'agreement among raft nodes before linearized reading' (duration: 251.101596ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:01:04.098295Z","caller":"traceutil/trace.go:171","msg":"trace[1283977320] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"397.812058ms","start":"2026-09-21T03:01:03.700268Z","end":"2026-09-21T03:01:04.09808Z","steps":["trace[1283977320] 'process raft request' (duration: 397.483799ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:01:04.099106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:01:03.700249Z","time spent":"398.213369ms","remote":"127.0.0.1:60494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-21T03:01:10.401857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.834695ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-21T03:01:10.402252Z","caller":"traceutil/trace.go:171","msg":"trace[959468619] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"246.079378ms","start":"2026-09-21T03:01:10.156153Z","end":"2026-09-21T03:01:10.402232Z","steps":["trace[959468619] 'process raft request' (duration: 64.780862ms)","trace[959468619] 'compare' (duration: 180.612989ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:01:10.923687Z","caller":"traceutil/trace.go:171","msg":"trace[688416826] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"435.832238ms","start":"2026-09-21T03:01:10.487821Z","end":"2026-09-21T03:01:10.923653Z","steps":["trace[688416826] 'process raft request' (duration: 435.597863ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:01:10.923707Z","caller":"traceutil/trace.go:171","msg":"trace[1911245546] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"434.707589ms","start":"2026-09-21T03:01:10.488975Z","end":"2026-09-21T03:01:10.923682Z","steps":["trace[1911245546] 'process raft request' (duration: 434.651938ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:01:10.92387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:01:10.487807Z","time spent":"435.962251ms","remote":"127.0.0.1:60526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-21T03:01:10.923743Z","caller":"traceutil/trace.go:171","msg":"trace[1108135355] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"434.975216ms","start":"2026-09-21T03:01:10.48874Z","end":"2026-09-21T03:01:10.923716Z","steps":["trace[1108135355] 'process raft request' (duration: 434.815082ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:01:10.924116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:01:10.488963Z","time spent":"434.813842ms","remote":"127.0.0.1:60648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-21T03:01:10.924306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:01:10.488728Z","time spent":"435.412717ms","remote":"127.0.0.1:60712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-21T03:01:10.946877Z","caller":"traceutil/trace.go:171","msg":"trace[147753916] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:636; }","duration":"285.887297ms","start":"2026-09-21T03:01:10.660947Z","end":"2026-09-21T03:01:10.946835Z","steps":["trace[147753916] 'read index received' (duration: 262.556286ms)","trace[147753916] 'applied index is now lower than readState.Index' (duration: 23.330011ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:01:10.946913Z","caller":"traceutil/trace.go:171","msg":"trace[1100319234] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"446.316413ms","start":"2026-09-21T03:01:10.50058Z","end":"2026-09-21T03:01:10.946896Z","steps":["trace[1100319234] 'process raft request' (duration: 446.117238ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:01:10.947165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:01:10.500552Z","time spent":"446.532989ms","remote":"127.0.0.1:60648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-21T03:01:10.947186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.230815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-21T03:01:10.947449Z","caller":"traceutil/trace.go:171","msg":"trace[2116309740] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"286.498033ms","start":"2026-09-21T03:01:10.660893Z","end":"2026-09-21T03:01:10.947391Z","steps":["trace[2116309740] 'agreement among raft nodes before linearized reading' (duration: 286.04572ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:01:59.407242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.536207ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-21T03:01:59.407415Z","caller":"traceutil/trace.go:171","msg":"trace[745735997] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"182.12541ms","start":"2026-09-21T03:01:59.225255Z","end":"2026-09-21T03:01:59.40738Z","steps":["trace[745735997] 'process raft request' (duration: 78.329629ms)","trace[745735997] 'compare' (duration: 103.367954ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:02:50.474072Z","caller":"traceutil/trace.go:171","msg":"trace[1811640164] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"226.252538ms","start":"2026-09-21T03:02:50.247771Z","end":"2026-09-21T03:02:50.474023Z","steps":["trace[1811640164] 'process raft request' (duration: 226.068184ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:03:02.739684Z","caller":"traceutil/trace.go:171","msg":"trace[359014519] linearizableReadLoop","detail":"{readStateIndex:2057; appliedIndex:2056; }","duration":"121.156528ms","start":"2026-09-21T03:03:02.618502Z","end":"2026-09-21T03:03:02.739658Z","steps":["trace[359014519] 'read index received' (duration: 120.985426ms)","trace[359014519] 'applied index is now lower than readState.Index' (duration: 170.242µs)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:03:02.73976Z","caller":"traceutil/trace.go:171","msg":"trace[808384030] transaction","detail":"{read_only:false; response_revision:1978; number_of_response:1; }","duration":"143.672292ms","start":"2026-09-21T03:03:02.596041Z","end":"2026-09-21T03:03:02.739713Z","steps":["trace[808384030] 'process raft request' (duration: 143.440499ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:03:02.73984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.29768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-21T03:03:02.739899Z","caller":"traceutil/trace.go:171","msg":"trace[291240682] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1978; }","duration":"121.428442ms","start":"2026-09-21T03:03:02.618455Z","end":"2026-09-21T03:03:02.739884Z","steps":["trace[291240682] 'agreement among raft nodes before linearized reading' (duration: 121.296501ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:03:25.146329Z","caller":"traceutil/trace.go:171","msg":"trace[564980192] linearizableReadLoop","detail":"{readStateIndex:2200; appliedIndex:2199; }","duration":"113.497892ms","start":"2026-09-21T03:03:25.032806Z","end":"2026-09-21T03:03:25.146304Z","steps":["trace[564980192] 'read index received' (duration: 113.39506ms)","trace[564980192] 'applied index is now lower than readState.Index' (duration: 101.442µs)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:03:25.146395Z","caller":"traceutil/trace.go:171","msg":"trace[701953604] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"115.415836ms","start":"2026-09-21T03:03:25.030946Z","end":"2026-09-21T03:03:25.146361Z","steps":["trace[701953604] 'process raft request' (duration: 115.215082ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:03:25.146619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.788076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-21T03:03:25.146697Z","caller":"traceutil/trace.go:171","msg":"trace[247272623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2117; }","duration":"113.904137ms","start":"2026-09-21T03:03:25.032781Z","end":"2026-09-21T03:03:25.146685Z","steps":["trace[247272623] 'agreement among raft nodes before linearized reading' (duration: 113.657694ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:03:25.360464Z","caller":"traceutil/trace.go:171","msg":"trace[1614009375] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2200; }","duration":"213.83792ms","start":"2026-09-21T03:03:25.146594Z","end":"2026-09-21T03:03:25.360431Z","steps":["trace[1614009375] 'read index received' (duration: 131.37768ms)","trace[1614009375] 'applied index is now lower than readState.Index' (duration: 82.4591ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:03:25.360705Z","caller":"traceutil/trace.go:171","msg":"trace[1302692421] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"224.995797ms","start":"2026-09-21T03:03:25.135683Z","end":"2026-09-21T03:03:25.360678Z","steps":["trace[1302692421] 'process raft request' (duration: 142.302554ms)","trace[1302692421] 'compare' (duration: 82.292098ms)"],"step_count":2} {"level":"warn","ts":"2026-09-21T03:03:25.361156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.356334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-09-21T03:03:25.361269Z","caller":"traceutil/trace.go:171","msg":"trace[1999846575] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2118; }","duration":"319.548766ms","start":"2026-09-21T03:03:25.041702Z","end":"2026-09-21T03:03:25.36125Z","steps":["trace[1999846575] 'agreement among raft nodes before linearized reading' (duration: 318.990049ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:03:25.361437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:03:25.041688Z","time spent":"319.725109ms","remote":"127.0.0.1:60754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-21T03:03:25.393556Z","caller":"traceutil/trace.go:171","msg":"trace[577843612] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"242.442652ms","start":"2026-09-21T03:03:25.151074Z","end":"2026-09-21T03:03:25.393517Z","steps":["trace[577843612] 'process raft request' (duration: 241.896505ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:03:25.602027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.712638ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-21T03:03:25.602252Z","caller":"traceutil/trace.go:171","msg":"trace[1646101927] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"161.930604ms","start":"2026-09-21T03:03:25.440296Z","end":"2026-09-21T03:03:25.602227Z","steps":["trace[1646101927] 'process raft request' (duration: 161.852583ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:03:25.602391Z","caller":"traceutil/trace.go:171","msg":"trace[587132458] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"235.521877ms","start":"2026-09-21T03:03:25.366836Z","end":"2026-09-21T03:03:25.602358Z","steps":["trace[587132458] 'process raft request' (duration: 110.368484ms)","trace[587132458] 'compare' (duration: 124.482315ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:03:25.602579Z","caller":"traceutil/trace.go:171","msg":"trace[1172009260] linearizableReadLoop","detail":"{readStateIndex:2203; appliedIndex:2202; }","duration":"209.437366ms","start":"2026-09-21T03:03:25.393117Z","end":"2026-09-21T03:03:25.602555Z","steps":["trace[1172009260] 'read index received' (duration: 84.096371ms)","trace[1172009260] 'applied index is now lower than readState.Index' (duration: 125.339295ms)"],"step_count":2} {"level":"warn","ts":"2026-09-21T03:03:25.602943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.674336ms","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":"warn","ts":"2026-09-21T03:03:25.603041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.769269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-21T03:03:25.603096Z","caller":"traceutil/trace.go:171","msg":"trace[57827537] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2121; }","duration":"208.88967ms","start":"2026-09-21T03:03:25.394193Z","end":"2026-09-21T03:03:25.603083Z","steps":["trace[57827537] 'agreement among raft nodes before linearized reading' (duration: 208.779449ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:03:25.603073Z","caller":"traceutil/trace.go:171","msg":"trace[2081789767] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2121; }","duration":"238.832548ms","start":"2026-09-21T03:03:25.364211Z","end":"2026-09-21T03:03:25.603043Z","steps":["trace[2081789767] 'agreement among raft nodes before linearized reading' (duration: 238.598234ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:04:34.604748Z","caller":"traceutil/trace.go:171","msg":"trace[595315494] transaction","detail":"{read_only:false; response_revision:2595; number_of_response:1; }","duration":"125.295149ms","start":"2026-09-21T03:04:34.479394Z","end":"2026-09-21T03:04:34.604689Z","steps":["trace[595315494] 'process raft request' (duration: 124.922805ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:09:39.43278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.019109ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-21T03:09:39.432928Z","caller":"traceutil/trace.go:171","msg":"trace[802142625] linearizableReadLoop","detail":"{readStateIndex:5074; appliedIndex:5073; }","duration":"184.228828ms","start":"2026-09-21T03:09:39.24868Z","end":"2026-09-21T03:09:39.432909Z","steps":["trace[802142625] 'read index received' (duration: 48.073736ms)","trace[802142625] 'applied index is now lower than readState.Index' (duration: 136.153231ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:09:39.433127Z","caller":"traceutil/trace.go:171","msg":"trace[602545399] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"186.207218ms","start":"2026-09-21T03:09:39.246873Z","end":"2026-09-21T03:09:39.43308Z","steps":["trace[602545399] 'process raft request' (duration: 49.792973ms)","trace[602545399] 'compare' (duration: 135.804766ms)"],"step_count":2} {"level":"warn","ts":"2026-09-21T03:09:39.433264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.581634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-56ef8504-a592-4d20-835e-527fa3fcdc93\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-09-21T03:09:39.433299Z","caller":"traceutil/trace.go:171","msg":"trace[238702350] range","detail":"{range_begin:/registry/persistentvolumes/pvc-56ef8504-a592-4d20-835e-527fa3fcdc93; range_end:; response_count:1; response_revision:4886; }","duration":"184.659024ms","start":"2026-09-21T03:09:39.248628Z","end":"2026-09-21T03:09:39.433287Z","steps":["trace[238702350] 'agreement among raft nodes before linearized reading' (duration: 184.533522ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:09:39.471899Z","caller":"traceutil/trace.go:171","msg":"trace[100985569] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"222.538372ms","start":"2026-09-21T03:09:39.24932Z","end":"2026-09-21T03:09:39.471859Z","steps":["trace[100985569] 'process raft request' (duration: 222.280908ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:09:39.472096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.718281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-21T03:09:39.472214Z","caller":"traceutil/trace.go:171","msg":"trace[1556457586] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:4887; }","duration":"129.908235ms","start":"2026-09-21T03:09:39.342275Z","end":"2026-09-21T03:09:39.472184Z","steps":["trace[1556457586] 'agreement among raft nodes before linearized reading' (duration: 129.60885ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:09:45.380466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.519137ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-21T03:09:45.38059Z","caller":"traceutil/trace.go:171","msg":"trace[1162008485] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"227.197261ms","start":"2026-09-21T03:09:45.153369Z","end":"2026-09-21T03:09:45.380566Z","steps":["trace[1162008485] 'process raft request' (duration: 93.477721ms)","trace[1162008485] 'compare' (duration: 133.377535ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:09:45.458686Z","caller":"traceutil/trace.go:171","msg":"trace[1870996592] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"304.040054ms","start":"2026-09-21T03:09:45.154592Z","end":"2026-09-21T03:09:45.458632Z","steps":["trace[1870996592] 'process raft request' (duration: 303.78509ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:09:45.458714Z","caller":"traceutil/trace.go:171","msg":"trace[279214014] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"303.984504ms","start":"2026-09-21T03:09:45.154702Z","end":"2026-09-21T03:09:45.458686Z","steps":["trace[279214014] 'process raft request' (duration: 303.825301ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:09:45.458904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:09:45.154693Z","time spent":"304.126536ms","remote":"127.0.0.1:60756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1869,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-21T03:09:45.458933Z","caller":"traceutil/trace.go:171","msg":"trace[278809841] linearizableReadLoop","detail":"{readStateIndex:5139; appliedIndex:5136; }","duration":"193.568792ms","start":"2026-09-21T03:09:45.265341Z","end":"2026-09-21T03:09:45.45891Z","steps":["trace[278809841] 'read index received' (duration: 193.090695ms)","trace[278809841] 'applied index is now lower than readState.Index' (duration: 476.987µs)"],"step_count":2} {"level":"warn","ts":"2026-09-21T03:09:45.458963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:09:45.154558Z","time spent":"304.277978ms","remote":"127.0.0.1:60630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":906,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-21T03:09:45.459164Z","caller":"traceutil/trace.go:171","msg":"trace[2005072231] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"303.025429ms","start":"2026-09-21T03:09:45.156129Z","end":"2026-09-21T03:09:45.459155Z","steps":["trace[2005072231] 'process raft request' (duration: 302.45882ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:09:45.459259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-21T03:09:45.156101Z","time spent":"303.087981ms","remote":"127.0.0.1:60756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1455,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-21T03:09:45.459308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.963348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-21T03:09:45.459361Z","caller":"traceutil/trace.go:171","msg":"trace[1617895534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4949; }","duration":"194.05871ms","start":"2026-09-21T03:09:45.26529Z","end":"2026-09-21T03:09:45.459348Z","steps":["trace[1617895534] 'agreement among raft nodes before linearized reading' (duration: 193.925548ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:09:45.497516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.165941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-21T03:09:45.497601Z","caller":"traceutil/trace.go:171","msg":"trace[1359559932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4951; }","duration":"168.296683ms","start":"2026-09-21T03:09:45.329283Z","end":"2026-09-21T03:09:45.49758Z","steps":["trace[1359559932] 'agreement among raft nodes before linearized reading' (duration: 168.174292ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:09:45.798277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.676663ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-21T03:09:45.798694Z","caller":"traceutil/trace.go:171","msg":"trace[1444334463] linearizableReadLoop","detail":"{readStateIndex:5143; appliedIndex:5142; }","duration":"142.856271ms","start":"2026-09-21T03:09:45.655816Z","end":"2026-09-21T03:09:45.798672Z","steps":["trace[1444334463] 'read index received' (duration: 39.251µs)","trace[1444334463] 'applied index is now lower than readState.Index' (duration: 142.81527ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:09:45.798809Z","caller":"traceutil/trace.go:171","msg":"trace[49241547] transaction","detail":"{read_only:false; response_revision:4953; number_of_response:1; }","duration":"229.406195ms","start":"2026-09-21T03:09:45.569347Z","end":"2026-09-21T03:09:45.798753Z","steps":["trace[49241547] 'process raft request' (duration: 52.135962ms)","trace[49241547] 'compare' (duration: 176.149625ms)"],"step_count":2} {"level":"warn","ts":"2026-09-21T03:09:45.79898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.172146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-21T03:09:45.799069Z","caller":"traceutil/trace.go:171","msg":"trace[741811776] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4953; }","duration":"143.325348ms","start":"2026-09-21T03:09:45.655725Z","end":"2026-09-21T03:09:45.79905Z","steps":["trace[741811776] 'agreement among raft nodes before linearized reading' (duration: 143.033554ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:09:58.540688Z","caller":"traceutil/trace.go:171","msg":"trace[172209635] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"214.585783ms","start":"2026-09-21T03:09:58.326074Z","end":"2026-09-21T03:09:58.54066Z","steps":["trace[172209635] 'process raft request' (duration: 184.048399ms)","trace[172209635] 'compare' (duration: 30.360752ms)"],"step_count":2} {"level":"info","ts":"2026-09-21T03:09:58.540912Z","caller":"traceutil/trace.go:171","msg":"trace[1876042512] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"212.440391ms","start":"2026-09-21T03:09:58.328457Z","end":"2026-09-21T03:09:58.540897Z","steps":["trace[1876042512] 'process raft request' (duration: 212.163297ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:09:58.541193Z","caller":"traceutil/trace.go:171","msg":"trace[162665039] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"212.123445ms","start":"2026-09-21T03:09:58.329057Z","end":"2026-09-21T03:09:58.541181Z","steps":["trace[162665039] 'process raft request' (duration: 211.79321ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:09:58.541237Z","caller":"traceutil/trace.go:171","msg":"trace[1610420677] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"138.602757ms","start":"2026-09-21T03:09:58.402605Z","end":"2026-09-21T03:09:58.541208Z","steps":["trace[1610420677] 'process raft request' (duration: 138.478756ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:09:58.541421Z","caller":"traceutil/trace.go:171","msg":"trace[1045766618] linearizableReadLoop","detail":"{readStateIndex:5373; appliedIndex:5371; }","duration":"212.664493ms","start":"2026-09-21T03:09:58.328746Z","end":"2026-09-21T03:09:58.54141Z","steps":["trace[1045766618] 'read index received' (duration: 9.242421ms)","trace[1045766618] 'applied index is now lower than readState.Index' (duration: 203.420832ms)"],"step_count":2} {"level":"warn","ts":"2026-09-21T03:09:58.541568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.237182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-21T03:09:58.541576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.818916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-q6kws\" ","response":"range_response_count:1 size:9942"} {"level":"info","ts":"2026-09-21T03:09:58.541606Z","caller":"traceutil/trace.go:171","msg":"trace[271242428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5178; }","duration":"211.320453ms","start":"2026-09-21T03:09:58.330274Z","end":"2026-09-21T03:09:58.541595Z","steps":["trace[271242428] 'agreement among raft nodes before linearized reading' (duration: 211.254962ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:09:58.541614Z","caller":"traceutil/trace.go:171","msg":"trace[1637860347] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-q6kws; range_end:; response_count:1; response_revision:5178; }","duration":"212.886877ms","start":"2026-09-21T03:09:58.328716Z","end":"2026-09-21T03:09:58.541603Z","steps":["trace[1637860347] 'agreement among raft nodes before linearized reading' (duration: 212.762165ms)"],"step_count":1} {"level":"warn","ts":"2026-09-21T03:09:58.542906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.171583ms","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-09-21T03:09:58.544709Z","caller":"traceutil/trace.go:171","msg":"trace[156539987] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5178; }","duration":"203.988032ms","start":"2026-09-21T03:09:58.340704Z","end":"2026-09-21T03:09:58.544692Z","steps":["trace[156539987] 'agreement among raft nodes before linearized reading' (duration: 202.125583ms)"],"step_count":1} {"level":"info","ts":"2026-09-21T03:10:22.380098Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2855} {"level":"info","ts":"2026-09-21T03:10:22.458241Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2855,"took":"77.160528ms","hash":651070072,"current-db-size-bytes":53514240,"current-db-size":"54 MB","current-db-size-in-use-bytes":28442624,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-21T03:10:22.458287Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":651070072,"revision":2855,"compact-revision":-1} {"level":"info","ts":"2026-09-21T03:15:22.389286Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5419} {"level":"info","ts":"2026-09-21T03:15:22.5039Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5419,"took":"113.102272ms","hash":3634174710,"current-db-size-bytes":53514240,"current-db-size":"54 MB","current-db-size-in-use-bytes":18907136,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-21T03:15:22.503955Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3634174710,"revision":5419,"compact-revision":2855}