{"level":"warn","ts":"2026-09-29T03:44:01.416838Z","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-29T03:44:01.416956Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43: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.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43: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-29T03:44:01.417044Z","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-29T03:44:01.417065Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-09-29T03:44:01.417091Z","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-29T03:44:01.41823Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]} {"level":"info","ts":"2026-09-29T03:44:01.418384Z","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.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43: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-29T03:44:01.424544Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.492566ms"} {"level":"info","ts":"2026-09-29T03:44:01.433378Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"} {"level":"info","ts":"2026-09-29T03:44:01.433476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"} {"level":"info","ts":"2026-09-29T03:44:01.433505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"} {"level":"info","ts":"2026-09-29T03:44:01.433572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-29T03:44:01.433584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"} {"level":"info","ts":"2026-09-29T03:44:01.433643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"warn","ts":"2026-09-29T03:44:01.443328Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-29T03:44:01.445234Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-29T03:44:01.448037Z","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-29T03:44:01.452514Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-29T03:44:01.452708Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-29T03:44:01.45273Z","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-29T03:44:01.452865Z","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-29T03:44:01.45288Z","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-29T03:44:01.459634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"info","ts":"2026-09-29T03:44:01.460052Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-09-29T03:44:01.460092Z","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-29T03:44:01.46012Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-09-29T03:44:01.460707Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-09-29T03:44:01.461013Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-29T03:44:01.461096Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-29T03:44:01.534139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"} {"level":"info","ts":"2026-09-29T03:44:01.534231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"} {"level":"info","ts":"2026-09-29T03:44:01.534291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"} {"level":"info","ts":"2026-09-29T03:44:01.534319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"} {"level":"info","ts":"2026-09-29T03:44:01.534334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-09-29T03:44:01.534356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"} {"level":"info","ts":"2026-09-29T03:44:01.53438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-09-29T03:44:01.535391Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:44:01.535573Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"} {"level":"info","ts":"2026-09-29T03:44:01.535574Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T03:44:01.535639Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T03:44:01.536006Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-29T03:44:01.536078Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-29T03:44:01.537643Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"} {"level":"info","ts":"2026-09-29T03:44:01.537916Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:44:01.538187Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:44:01.538265Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:44:01.538736Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-29T03:44:05.672638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.959439ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-29T03:44:05.672786Z","caller":"traceutil/trace.go:171","msg":"trace[1509023549] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"390.588982ms","start":"2026-09-29T03:44:05.282177Z","end":"2026-09-29T03:44:05.672766Z","steps":["trace[1509023549] 'process raft request' (duration: 163.926628ms)","trace[1509023549] 'compare' (duration: 225.785021ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:44:05.672846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:05.282156Z","time spent":"390.66822ms","remote":"127.0.0.1:51736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":465,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-29T03:44:05.930137Z","caller":"traceutil/trace.go:171","msg":"trace[1448284809] linearizableReadLoop","detail":"{readStateIndex:208; appliedIndex:207; }","duration":"136.879576ms","start":"2026-09-29T03:44:05.793225Z","end":"2026-09-29T03:44:05.930105Z","steps":["trace[1448284809] 'read index received' (duration: 136.620128ms)","trace[1448284809] 'applied index is now lower than readState.Index' (duration: 258.058µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:44:05.930182Z","caller":"traceutil/trace.go:171","msg":"trace[962956268] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"226.714182ms","start":"2026-09-29T03:44:05.703443Z","end":"2026-09-29T03:44:05.930157Z","steps":["trace[962956268] 'process raft request' (duration: 226.431925ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:05.930353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.106344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T03:44:05.930442Z","caller":"traceutil/trace.go:171","msg":"trace[31197386] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:203; }","duration":"137.269682ms","start":"2026-09-29T03:44:05.793151Z","end":"2026-09-29T03:44:05.930421Z","steps":["trace[31197386] 'agreement among raft nodes before linearized reading' (duration: 137.102544ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:48.739687Z","caller":"traceutil/trace.go:171","msg":"trace[263481235] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"110.046214ms","start":"2026-09-29T03:44:48.629621Z","end":"2026-09-29T03:44:48.739668Z","steps":["trace[263481235] 'process raft request' (duration: 109.897279ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:49.391046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.802895ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T03:44:49.391272Z","caller":"traceutil/trace.go:171","msg":"trace[359736339] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"599.060702ms","start":"2026-09-29T03:44:48.792184Z","end":"2026-09-29T03:44:49.391244Z","steps":["trace[359736339] 'process raft request' (duration: 335.866573ms)","trace[359736339] 'compare' (duration: 262.646459ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:44:49.391435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.792161Z","time spent":"599.206108ms","remote":"127.0.0.1:51478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T03:44:49.391612Z","caller":"traceutil/trace.go:171","msg":"trace[1867131241] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:549; }","duration":"596.22368ms","start":"2026-09-29T03:44:48.795357Z","end":"2026-09-29T03:44:49.39158Z","steps":["trace[1867131241] 'read index received' (duration: 15.805463ms)","trace[1867131241] 'applied index is now lower than readState.Index' (duration: 580.416787ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:44:49.391835Z","caller":"traceutil/trace.go:171","msg":"trace[1042422617] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"589.231897ms","start":"2026-09-29T03:44:48.802518Z","end":"2026-09-29T03:44:49.39175Z","steps":["trace[1042422617] 'process raft request' (duration: 588.856453ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:49.391924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.51478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-09-29T03:44:49.391983Z","caller":"traceutil/trace.go:171","msg":"trace[1861386876] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:534; }","duration":"596.623834ms","start":"2026-09-29T03:44:48.79534Z","end":"2026-09-29T03:44:49.391964Z","steps":["trace[1861386876] 'agreement among raft nodes before linearized reading' (duration: 596.423726ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:49.391645Z","caller":"traceutil/trace.go:171","msg":"trace[254687154] transaction","detail":"{read_only:false; number_of_response:0; response_revision:532; }","duration":"596.119195ms","start":"2026-09-29T03:44:48.795503Z","end":"2026-09-29T03:44:49.391623Z","steps":["trace[254687154] 'process raft request' (duration: 595.631307ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:49.392012Z","caller":"traceutil/trace.go:171","msg":"trace[499029182] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"580.988778ms","start":"2026-09-29T03:44:48.811Z","end":"2026-09-29T03:44:49.391989Z","steps":["trace[499029182] 'process raft request' (duration: 580.526021ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:49.39204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.795333Z","time spent":"596.692827ms","remote":"127.0.0.1:51958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":1032,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-09-29T03:44:49.392084Z","caller":"traceutil/trace.go:171","msg":"trace[1167531737] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"548.17134ms","start":"2026-09-29T03:44:48.843899Z","end":"2026-09-29T03:44:49.39207Z","steps":["trace[1167531737] 'process raft request' (duration: 548.105397ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:49.392092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.795487Z","time spent":"596.557622ms","remote":"127.0.0.1:51958","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T03:44:49.392088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.802499Z","time spent":"589.465995ms","remote":"127.0.0.1:51478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T03:44:49.392111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.810972Z","time spent":"581.091262ms","remote":"127.0.0.1:51478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T03:44:49.392111Z","caller":"traceutil/trace.go:171","msg":"trace[1249695719] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"567.453368ms","start":"2026-09-29T03:44:48.824639Z","end":"2026-09-29T03:44:49.392092Z","steps":["trace[1249695719] 'process raft request' (duration: 567.130536ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:49.392191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.843879Z","time spent":"548.252783ms","remote":"127.0.0.1:51478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T03:44:49.392276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.824621Z","time spent":"567.581913ms","remote":"127.0.0.1:51478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T03:44:49.392442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.095079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:1019"} {"level":"info","ts":"2026-09-29T03:44:49.392484Z","caller":"traceutil/trace.go:171","msg":"trace[1306810571] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:536; }","duration":"574.154711ms","start":"2026-09-29T03:44:48.818313Z","end":"2026-09-29T03:44:49.392468Z","steps":["trace[1306810571] 'agreement among raft nodes before linearized reading' (duration: 574.012865ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:49.39249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.543344ms","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-09-29T03:44:49.39253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.818304Z","time spent":"574.218394ms","remote":"127.0.0.1:51958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1041,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" "} {"level":"info","ts":"2026-09-29T03:44:49.392542Z","caller":"traceutil/trace.go:171","msg":"trace[105084510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:536; }","duration":"503.611956ms","start":"2026-09-29T03:44:48.888917Z","end":"2026-09-29T03:44:49.392529Z","steps":["trace[105084510] 'agreement among raft nodes before linearized reading' (duration: 503.519582ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:49.39258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.888908Z","time spent":"503.662398ms","remote":"127.0.0.1:51726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-29T03:44:49.392607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.238574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-09-29T03:44:49.392667Z","caller":"traceutil/trace.go:171","msg":"trace[1811304602] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:536; }","duration":"574.305576ms","start":"2026-09-29T03:44:48.818341Z","end":"2026-09-29T03:44:49.392647Z","steps":["trace[1811304602] 'agreement among raft nodes before linearized reading' (duration: 574.110329ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:49.39271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.818339Z","time spent":"574.360248ms","remote":"127.0.0.1:51958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1035,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-09-29T03:44:56.088333Z","caller":"traceutil/trace.go:171","msg":"trace[1864726460] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"169.220204ms","start":"2026-09-29T03:44:55.919082Z","end":"2026-09-29T03:44:56.088302Z","steps":["trace[1864726460] 'process raft request' (duration: 168.581127ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:56.33889Z","caller":"traceutil/trace.go:171","msg":"trace[746149820] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"162.256017ms","start":"2026-09-29T03:44:56.176615Z","end":"2026-09-29T03:44:56.338871Z","steps":["trace[746149820] 'read index received' (duration: 162.07852ms)","trace[746149820] 'applied index is now lower than readState.Index' (duration: 176.737µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:44:56.339174Z","caller":"traceutil/trace.go:171","msg":"trace[618721370] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"170.629186ms","start":"2026-09-29T03:44:56.168535Z","end":"2026-09-29T03:44:56.339164Z","steps":["trace[618721370] 'process raft request' (duration: 170.216539ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:56.339521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.891024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-29T03:44:56.339607Z","caller":"traceutil/trace.go:171","msg":"trace[1795463698] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"163.02435ms","start":"2026-09-29T03:44:56.17656Z","end":"2026-09-29T03:44:56.339584Z","steps":["trace[1795463698] 'agreement among raft nodes before linearized reading' (duration: 162.816461ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:56.339994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.902354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ttlx8\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-29T03:44:56.340034Z","caller":"traceutil/trace.go:171","msg":"trace[267940732] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ttlx8; range_end:; response_count:1; response_revision:609; }","duration":"118.978198ms","start":"2026-09-29T03:44:56.221047Z","end":"2026-09-29T03:44:56.340025Z","steps":["trace[267940732] 'agreement among raft nodes before linearized reading' (duration: 118.394294ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:56.616186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.957592ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T03:44:56.616291Z","caller":"traceutil/trace.go:171","msg":"trace[1540717751] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"271.836594ms","start":"2026-09-29T03:44:56.344436Z","end":"2026-09-29T03:44:56.616272Z","steps":["trace[1540717751] 'process raft request' (duration: 155.702935ms)","trace[1540717751] 'compare' (duration: 115.843437ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:44:56.637378Z","caller":"traceutil/trace.go:171","msg":"trace[1537899761] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"291.575885ms","start":"2026-09-29T03:44:56.345788Z","end":"2026-09-29T03:44:56.637364Z","steps":["trace[1537899761] 'process raft request' (duration: 291.392448ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:56.637716Z","caller":"traceutil/trace.go:171","msg":"trace[746163126] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:634; }","duration":"285.058204ms","start":"2026-09-29T03:44:56.352633Z","end":"2026-09-29T03:44:56.637691Z","steps":["trace[746163126] 'read index received' (duration: 147.517154ms)","trace[746163126] 'applied index is now lower than readState.Index' (duration: 137.54023ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:44:56.637862Z","caller":"traceutil/trace.go:171","msg":"trace[440277559] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"277.408346ms","start":"2026-09-29T03:44:56.36044Z","end":"2026-09-29T03:44:56.637848Z","steps":["trace[440277559] 'process raft request' (duration: 277.161176ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:56.637933Z","caller":"traceutil/trace.go:171","msg":"trace[1657709989] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"291.977892ms","start":"2026-09-29T03:44:56.345919Z","end":"2026-09-29T03:44:56.637897Z","steps":["trace[1657709989] 'process raft request' (duration: 291.389648ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:56.638198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.554235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T03:44:56.63825Z","caller":"traceutil/trace.go:171","msg":"trace[250396045] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:613; }","duration":"285.642289ms","start":"2026-09-29T03:44:56.35258Z","end":"2026-09-29T03:44:56.638223Z","steps":["trace[250396045] 'agreement among raft nodes before linearized reading' (duration: 285.569616ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:57.330738Z","caller":"traceutil/trace.go:171","msg":"trace[243977191] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"288.266348ms","start":"2026-09-29T03:44:57.042444Z","end":"2026-09-29T03:44:57.33071Z","steps":["trace[243977191] 'process raft request' (duration: 287.744066ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:58.599798Z","caller":"traceutil/trace.go:171","msg":"trace[1522903711] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"132.346298ms","start":"2026-09-29T03:44:58.467411Z","end":"2026-09-29T03:44:58.599757Z","steps":["trace[1522903711] 'process raft request' (duration: 127.101334ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:45:13.639616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.249978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-c4zvx\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-29T03:45:13.639673Z","caller":"traceutil/trace.go:171","msg":"trace[863133019] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-c4zvx; range_end:; response_count:1; response_revision:786; }","duration":"312.354643ms","start":"2026-09-29T03:45:13.327306Z","end":"2026-09-29T03:45:13.639661Z","steps":["trace[863133019] 'range keys from in-memory index tree' (duration: 312.111461ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:45:13.639696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:45:13.327267Z","time spent":"312.423057ms","remote":"127.0.0.1:51620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-c4zvx\" "} {"level":"info","ts":"2026-09-29T03:45:43.942664Z","caller":"traceutil/trace.go:171","msg":"trace[132095394] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"145.755079ms","start":"2026-09-29T03:45:43.796885Z","end":"2026-09-29T03:45:43.94264Z","steps":["trace[132095394] 'process raft request' (duration: 145.602059ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:08.81248Z","caller":"traceutil/trace.go:171","msg":"trace[891598218] transaction","detail":"{read_only:false; response_revision:1462; number_of_response:1; }","duration":"172.33264ms","start":"2026-09-29T03:46:08.640114Z","end":"2026-09-29T03:46:08.812447Z","steps":["trace[891598218] 'process raft request' (duration: 158.044288ms)","trace[891598218] 'compare' (duration: 14.141562ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:46:33.457503Z","caller":"traceutil/trace.go:171","msg":"trace[1055858398] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"230.178308ms","start":"2026-09-29T03:46:33.227303Z","end":"2026-09-29T03:46:33.457481Z","steps":["trace[1055858398] 'read index received' (duration: 230.004125ms)","trace[1055858398] 'applied index is now lower than readState.Index' (duration: 173.233µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:46:33.457634Z","caller":"traceutil/trace.go:171","msg":"trace[356227524] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"289.017937ms","start":"2026-09-29T03:46:33.168605Z","end":"2026-09-29T03:46:33.457623Z","steps":["trace[356227524] 'process raft request' (duration: 288.754678ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:33.457837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.529634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1d83b01b-f09a-4ae3-8452-a536b973a13a\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-29T03:46:33.457867Z","caller":"traceutil/trace.go:171","msg":"trace[1713918028] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1d83b01b-f09a-4ae3-8452-a536b973a13a; range_end:; response_count:1; response_revision:1877; }","duration":"230.630161ms","start":"2026-09-29T03:46:33.227227Z","end":"2026-09-29T03:46:33.457857Z","steps":["trace[1713918028] 'agreement among raft nodes before linearized reading' (duration: 230.507772ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:33.835516Z","caller":"traceutil/trace.go:171","msg":"trace[448706093] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"121.390698ms","start":"2026-09-29T03:46:33.714092Z","end":"2026-09-29T03:46:33.835482Z","steps":["trace[448706093] 'process raft request' (duration: 121.127759ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:50.389275Z","caller":"traceutil/trace.go:171","msg":"trace[659053811] linearizableReadLoop","detail":"{readStateIndex:2084; appliedIndex:2083; }","duration":"313.901401ms","start":"2026-09-29T03:46:50.075349Z","end":"2026-09-29T03:46:50.38925Z","steps":["trace[659053811] 'read index received' (duration: 313.660163ms)","trace[659053811] 'applied index is now lower than readState.Index' (duration: 239.478µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:46:50.389455Z","caller":"traceutil/trace.go:171","msg":"trace[2074781935] transaction","detail":"{read_only:false; response_revision:2006; number_of_response:1; }","duration":"388.081929ms","start":"2026-09-29T03:46:50.001307Z","end":"2026-09-29T03:46:50.389389Z","steps":["trace[2074781935] 'process raft request' (duration: 387.769756ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:50.389635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:46:50.001271Z","time spent":"388.266112ms","remote":"127.0.0.1:51726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T03:46:50.389677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.296471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:527"} {"level":"info","ts":"2026-09-29T03:46:50.389766Z","caller":"traceutil/trace.go:171","msg":"trace[1846061443] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2006; }","duration":"314.451032ms","start":"2026-09-29T03:46:50.075296Z","end":"2026-09-29T03:46:50.389748Z","steps":["trace[1846061443] 'agreement among raft nodes before linearized reading' (duration: 314.054372ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:50.389814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:46:50.07527Z","time spent":"314.532388ms","remote":"127.0.0.1:51726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":549,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-09-29T03:47:13.625998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.28468ms","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-29T03:47:13.626132Z","caller":"traceutil/trace.go:171","msg":"trace[881716457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2146; }","duration":"102.487396ms","start":"2026-09-29T03:47:13.523621Z","end":"2026-09-29T03:47:13.626109Z","steps":["trace[881716457] 'range keys from in-memory index tree' (duration: 102.115578ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:47:14.003119Z","caller":"traceutil/trace.go:171","msg":"trace[1464888995] linearizableReadLoop","detail":"{readStateIndex:2232; appliedIndex:2231; }","duration":"258.959626ms","start":"2026-09-29T03:47:13.744133Z","end":"2026-09-29T03:47:14.003092Z","steps":["trace[1464888995] 'read index received' (duration: 207.743835ms)","trace[1464888995] 'applied index is now lower than readState.Index' (duration: 51.214331ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:47:14.003389Z","caller":"traceutil/trace.go:171","msg":"trace[1146984342] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"274.658574ms","start":"2026-09-29T03:47:13.728715Z","end":"2026-09-29T03:47:14.003373Z","steps":["trace[1146984342] 'process raft request' (duration: 223.15196ms)","trace[1146984342] 'compare' (duration: 50.712503ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:47:14.004018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.849624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-29T03:47:14.004094Z","caller":"traceutil/trace.go:171","msg":"trace[881645884] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2148; }","duration":"259.968714ms","start":"2026-09-29T03:47:13.744109Z","end":"2026-09-29T03:47:14.004078Z","steps":["trace[881645884] 'agreement among raft nodes before linearized reading' (duration: 259.694143ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:47:14.034571Z","caller":"traceutil/trace.go:171","msg":"trace[1525068493] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"267.095035ms","start":"2026-09-29T03:47:13.767454Z","end":"2026-09-29T03:47:14.034549Z","steps":["trace[1525068493] 'process raft request' (duration: 266.89437ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:47:14.034681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.703179ms","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-09-29T03:47:14.034771Z","caller":"traceutil/trace.go:171","msg":"trace[918967092] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2149; }","duration":"258.825028ms","start":"2026-09-29T03:47:13.775903Z","end":"2026-09-29T03:47:14.034728Z","steps":["trace[918967092] 'agreement among raft nodes before linearized reading' (duration: 258.571638ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:47:14.84531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.845699ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T03:47:14.845453Z","caller":"traceutil/trace.go:171","msg":"trace[1958484565] linearizableReadLoop","detail":"{readStateIndex:2236; appliedIndex:2235; }","duration":"255.640719ms","start":"2026-09-29T03:47:14.58979Z","end":"2026-09-29T03:47:14.845431Z","steps":["trace[1958484565] 'read index received' (duration: 111.499328ms)","trace[1958484565] 'applied index is now lower than readState.Index' (duration: 144.139641ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:47:14.845581Z","caller":"traceutil/trace.go:171","msg":"trace[467928818] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"285.357048ms","start":"2026-09-29T03:47:14.560173Z","end":"2026-09-29T03:47:14.84553Z","steps":["trace[467928818] 'process raft request' (duration: 141.191885ms)","trace[467928818] 'compare' (duration: 143.437627ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:47:14.845683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.847414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T03:47:14.845759Z","caller":"traceutil/trace.go:171","msg":"trace[112796772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2152; }","duration":"255.994826ms","start":"2026-09-29T03:47:14.589746Z","end":"2026-09-29T03:47:14.845741Z","steps":["trace[112796772] 'agreement among raft nodes before linearized reading' (duration: 255.836574ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:47:14.874517Z","caller":"traceutil/trace.go:171","msg":"trace[1903180163] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"128.847274ms","start":"2026-09-29T03:47:14.745647Z","end":"2026-09-29T03:47:14.874494Z","steps":["trace[1903180163] 'process raft request' (duration: 128.709163ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:47:15.18478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.35621ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T03:47:15.184896Z","caller":"traceutil/trace.go:171","msg":"trace[889505469] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2153; }","duration":"126.48401ms","start":"2026-09-29T03:47:15.058395Z","end":"2026-09-29T03:47:15.184879Z","steps":["trace[889505469] 'range keys from in-memory index tree' (duration: 126.34254ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:47:15.18499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.600083ms","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-09-29T03:47:15.185046Z","caller":"traceutil/trace.go:171","msg":"trace[281129593] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2153; }","duration":"142.702291ms","start":"2026-09-29T03:47:15.042325Z","end":"2026-09-29T03:47:15.185028Z","steps":["trace[281129593] 'range keys from in-memory index tree' (duration: 142.413399ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:47:55.758209Z","caller":"traceutil/trace.go:171","msg":"trace[1551351015] transaction","detail":"{read_only:false; response_revision:2424; number_of_response:1; }","duration":"102.65319ms","start":"2026-09-29T03:47:55.655535Z","end":"2026-09-29T03:47:55.758188Z","steps":["trace[1551351015] 'process raft request' (duration: 102.365519ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:48:21.646908Z","caller":"traceutil/trace.go:171","msg":"trace[377140883] transaction","detail":"{read_only:false; response_revision:2613; number_of_response:1; }","duration":"139.227952ms","start":"2026-09-29T03:48:21.507642Z","end":"2026-09-29T03:48:21.64687Z","steps":["trace[377140883] 'process raft request' (duration: 138.951345ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:22.971181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.687595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-29T03:53:22.971271Z","caller":"traceutil/trace.go:171","msg":"trace[2049466881] linearizableReadLoop","detail":"{readStateIndex:5105; appliedIndex:5104; }","duration":"225.129207ms","start":"2026-09-29T03:53:22.746125Z","end":"2026-09-29T03:53:22.971254Z","steps":["trace[2049466881] 'read index received' (duration: 114.335655ms)","trace[2049466881] 'applied index is now lower than readState.Index' (duration: 110.792132ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:53:22.971347Z","caller":"traceutil/trace.go:171","msg":"trace[1176909083] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"276.863202ms","start":"2026-09-29T03:53:22.694434Z","end":"2026-09-29T03:53:22.971297Z","steps":["trace[1176909083] 'process raft request' (duration: 165.985985ms)","trace[1176909083] 'compare' (duration: 110.472353ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:53:22.97152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.377661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12972"} {"level":"info","ts":"2026-09-29T03:53:22.971595Z","caller":"traceutil/trace.go:171","msg":"trace[77366820] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4916; }","duration":"225.504639ms","start":"2026-09-29T03:53:22.746072Z","end":"2026-09-29T03:53:22.971576Z","steps":["trace[77366820] 'agreement among raft nodes before linearized reading' (duration: 225.239753ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:22.987384Z","caller":"traceutil/trace.go:171","msg":"trace[1354918755] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"139.304814ms","start":"2026-09-29T03:53:22.848045Z","end":"2026-09-29T03:53:22.98735Z","steps":["trace[1354918755] 'process raft request' (duration: 139.081711ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:22.987844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.705861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-29T03:53:22.987959Z","caller":"traceutil/trace.go:171","msg":"trace[1214376439] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4917; }","duration":"224.874101ms","start":"2026-09-29T03:53:22.763063Z","end":"2026-09-29T03:53:22.987937Z","steps":["trace[1214376439] 'agreement among raft nodes before linearized reading' (duration: 224.547002ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:22.987981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.169205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-29T03:53:22.988048Z","caller":"traceutil/trace.go:171","msg":"trace[1500384062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4917; }","duration":"130.293912ms","start":"2026-09-29T03:53:22.857738Z","end":"2026-09-29T03:53:22.988032Z","steps":["trace[1500384062] 'agreement among raft nodes before linearized reading' (duration: 130.055448ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:36.999624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.854251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-158a854b-e0f9-436d-a040-90d693e58926\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-29T03:53:36.999735Z","caller":"traceutil/trace.go:171","msg":"trace[519755164] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-158a854b-e0f9-436d-a040-90d693e58926; range_end:; response_count:1; response_revision:5135; }","duration":"121.01702ms","start":"2026-09-29T03:53:36.878689Z","end":"2026-09-29T03:53:36.999706Z","steps":["trace[519755164] 'range keys from in-memory index tree' (duration: 120.68548ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:37.312276Z","caller":"traceutil/trace.go:171","msg":"trace[983570646] transaction","detail":"{read_only:false; response_revision:5136; number_of_response:1; }","duration":"304.763773ms","start":"2026-09-29T03:53:37.007479Z","end":"2026-09-29T03:53:37.312243Z","steps":["trace[983570646] 'process raft request' (duration: 304.573262ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:37.312453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:53:37.007461Z","time spent":"304.893941ms","remote":"127.0.0.1:51620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3750,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T03:53:37.537529Z","caller":"traceutil/trace.go:171","msg":"trace[1195052268] linearizableReadLoop","detail":"{readStateIndex:5332; appliedIndex:5330; }","duration":"391.005294ms","start":"2026-09-29T03:53:37.146497Z","end":"2026-09-29T03:53:37.537502Z","steps":["trace[1195052268] 'read index received' (duration: 165.199537ms)","trace[1195052268] 'applied index is now lower than readState.Index' (duration: 225.804167ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:53:37.53758Z","caller":"traceutil/trace.go:171","msg":"trace[1621014597] transaction","detail":"{read_only:false; response_revision:5137; number_of_response:1; }","duration":"503.604078ms","start":"2026-09-29T03:53:37.033938Z","end":"2026-09-29T03:53:37.537543Z","steps":["trace[1621014597] 'process raft request' (duration: 458.117709ms)","trace[1621014597] 'compare' (duration: 45.270406ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:53:37.537737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:53:37.033913Z","time spent":"503.732067ms","remote":"127.0.0.1:51726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T03:53:37.537807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.289761ms","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-29T03:53:37.537867Z","caller":"traceutil/trace.go:171","msg":"trace[505542886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5137; }","duration":"391.400778ms","start":"2026-09-29T03:53:37.146449Z","end":"2026-09-29T03:53:37.53785Z","steps":["trace[505542886] 'agreement among raft nodes before linearized reading' (duration: 391.210316ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:37.537917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:53:37.146431Z","time spent":"391.473902ms","remote":"127.0.0.1:51726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-29T03:53:37.537939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.041244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-158a854b-e0f9-436d-a040-90d693e58926\" ","response":"range_response_count:1 size:3765"} {"level":"info","ts":"2026-09-29T03:53:37.538037Z","caller":"traceutil/trace.go:171","msg":"trace[910641203] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-158a854b-e0f9-436d-a040-90d693e58926; range_end:; response_count:1; response_revision:5137; }","duration":"219.188944ms","start":"2026-09-29T03:53:37.318826Z","end":"2026-09-29T03:53:37.538015Z","steps":["trace[910641203] 'agreement among raft nodes before linearized reading' (duration: 218.96291ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:48.299232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.537362ms","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-29T03:53:48.29933Z","caller":"traceutil/trace.go:171","msg":"trace[1033455372] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5226; }","duration":"131.711982ms","start":"2026-09-29T03:53:48.167596Z","end":"2026-09-29T03:53:48.299308Z","steps":["trace[1033455372] 'range keys from in-memory index tree' (duration: 131.341649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:48.299375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.838551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-29T03:53:48.299431Z","caller":"traceutil/trace.go:171","msg":"trace[1444284054] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5226; }","duration":"118.974809ms","start":"2026-09-29T03:53:48.180445Z","end":"2026-09-29T03:53:48.29942Z","steps":["trace[1444284054] 'range keys from in-memory index tree' (duration: 118.515771ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:48.465935Z","caller":"traceutil/trace.go:171","msg":"trace[1921225684] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"133.802291ms","start":"2026-09-29T03:53:48.332095Z","end":"2026-09-29T03:53:48.465898Z","steps":["trace[1921225684] 'process raft request' (duration: 70.702864ms)","trace[1921225684] 'compare' (duration: 62.939747ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:54:01.847621Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2833} {"level":"info","ts":"2026-09-29T03:54:01.938198Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2833,"took":"89.342802ms","hash":364248488,"current-db-size-bytes":52060160,"current-db-size":"52 MB","current-db-size-in-use-bytes":27652096,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-29T03:54:01.938365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":364248488,"revision":2833,"compact-revision":-1} {"level":"info","ts":"2026-09-29T03:54:25.35394Z","caller":"traceutil/trace.go:171","msg":"trace[2120290715] linearizableReadLoop","detail":"{readStateIndex:5745; appliedIndex:5744; }","duration":"127.097056ms","start":"2026-09-29T03:54:25.226817Z","end":"2026-09-29T03:54:25.353914Z","steps":["trace[2120290715] 'read index received' (duration: 126.901653ms)","trace[2120290715] 'applied index is now lower than readState.Index' (duration: 194.703µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:54:25.35433Z","caller":"traceutil/trace.go:171","msg":"trace[1194181771] transaction","detail":"{read_only:false; response_revision:5538; number_of_response:1; }","duration":"136.753154ms","start":"2026-09-29T03:54:25.21753Z","end":"2026-09-29T03:54:25.354283Z","steps":["trace[1194181771] 'process raft request' (duration: 136.245062ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:25.35436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.461689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-29T03:54:25.354492Z","caller":"traceutil/trace.go:171","msg":"trace[218433977] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:5538; }","duration":"127.671572ms","start":"2026-09-29T03:54:25.226806Z","end":"2026-09-29T03:54:25.354478Z","steps":["trace[218433977] 'agreement among raft nodes before linearized reading' (duration: 127.209063ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:56.908223Z","caller":"traceutil/trace.go:171","msg":"trace[1129474258] transaction","detail":"{read_only:false; response_revision:5785; number_of_response:1; }","duration":"132.669229ms","start":"2026-09-29T03:54:56.77553Z","end":"2026-09-29T03:54:56.908199Z","steps":["trace[1129474258] 'process raft request' (duration: 122.0541ms)","trace[1129474258] 'compare' (duration: 10.530514ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:59:01.854722Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5313} {"level":"info","ts":"2026-09-29T03:59:01.943855Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5313,"took":"86.963507ms","hash":2742019034,"current-db-size-bytes":52060160,"current-db-size":"52 MB","current-db-size-in-use-bytes":18763776,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-29T03:59:01.943948Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2742019034,"revision":5313,"compact-revision":2833} {"level":"info","ts":"2026-09-29T04:04:01.86278Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7366} {"level":"info","ts":"2026-09-29T04:04:01.92271Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7366,"took":"58.343299ms","hash":672758984,"current-db-size-bytes":52060160,"current-db-size":"52 MB","current-db-size-in-use-bytes":15327232,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-09-29T04:04:01.922892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":672758984,"revision":7366,"compact-revision":5313}