{"level":"warn","ts":"2026-05-11T07:12:36.121017Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T07:12:36.121097Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25: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-05-11T07:12:36.121265Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T07:12:36.121283Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-05-11T07:12:36.121402Z","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-05-11T07:12:36.122096Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-05-11T07:12:36.122259Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25: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-05-11T07:12:36.126502Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.977602ms"} {"level":"info","ts":"2026-05-11T07:12:36.133501Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-05-11T07:12:36.133751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T07:12:36.133908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-05-11T07:12:36.133959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T07:12:36.133973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-05-11T07:12:36.13413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-05-11T07:12:36.14309Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T07:12:36.145051Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T07:12:36.14629Z","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-05-11T07:12:36.148636Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T07:12:36.148714Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T07:12:36.148826Z","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-05-11T07:12:36.148915Z","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-05-11T07:12:36.148927Z","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-05-11T07:12:36.150037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-05-11T07:12:36.150855Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-05-11T07:12:36.152393Z","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-05-11T07:12:36.152587Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T07:12:36.152622Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T07:12:36.152768Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-05-11T07:12:36.152802Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-05-11T07:12:36.735367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T07:12:36.735435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T07:12:36.735476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-05-11T07:12:36.735495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-05-11T07:12:36.735512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-05-11T07:12:36.73554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-05-11T07:12:36.73563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-05-11T07:12:36.742027Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T07:12:36.742372Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T07:12:36.743441Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T07:12:36.743966Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T07:12:36.744169Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T07:12:36.744191Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T07:12:36.744224Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T07:12:36.744307Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T07:12:36.744338Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T07:12:36.747152Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T07:12:36.749114Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-05-11T07:12:43.344388Z","caller":"traceutil/trace.go:171","msg":"trace[834221375] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"408.738183ms","start":"2026-05-11T07:12:42.935637Z","end":"2026-05-11T07:12:43.344375Z","steps":["trace[834221375] 'process raft request' (duration: 408.574871ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:12:43.344349Z","caller":"traceutil/trace.go:171","msg":"trace[413895369] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:288; }","duration":"247.884658ms","start":"2026-05-11T07:12:43.096442Z","end":"2026-05-11T07:12:43.344327Z","steps":["trace[413895369] 'read index received' (duration: 247.688135ms)","trace[413895369] 'applied index is now lower than readState.Index' (duration: 195.643µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:12:43.344539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.087421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-11T07:12:43.34459Z","caller":"traceutil/trace.go:171","msg":"trace[1633568997] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:278; }","duration":"248.190664ms","start":"2026-05-11T07:12:43.096388Z","end":"2026-05-11T07:12:43.344578Z","steps":["trace[1633568997] 'agreement among raft nodes before linearized reading' (duration: 248.079051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:12:43.344712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:12:42.935609Z","time spent":"408.829545ms","remote":"127.0.0.1:57222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T07:12:43.627309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.961121ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T07:12:43.628002Z","caller":"traceutil/trace.go:171","msg":"trace[1495699019] linearizableReadLoop","detail":"{readStateIndex:290; appliedIndex:289; }","duration":"278.891485ms","start":"2026-05-11T07:12:43.349093Z","end":"2026-05-11T07:12:43.627985Z","steps":["trace[1495699019] 'read index received' (duration: 15.827757ms)","trace[1495699019] 'applied index is now lower than readState.Index' (duration: 263.062468ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:12:43.628024Z","caller":"traceutil/trace.go:171","msg":"trace[528664688] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"279.001687ms","start":"2026-05-11T07:12:43.348988Z","end":"2026-05-11T07:12:43.627989Z","steps":["trace[528664688] 'process raft request' (duration: 15.97777ms)","trace[528664688] 'compare' (duration: 261.816829ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:12:43.628155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.053387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:12:43.628232Z","caller":"traceutil/trace.go:171","msg":"trace[474193901] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:0; response_revision:279; }","duration":"279.158749ms","start":"2026-05-11T07:12:43.349061Z","end":"2026-05-11T07:12:43.628219Z","steps":["trace[474193901] 'agreement among raft nodes before linearized reading' (duration: 279.016867ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:12:43.761255Z","caller":"traceutil/trace.go:171","msg":"trace[1278212823] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"128.119117ms","start":"2026-05-11T07:12:43.633112Z","end":"2026-05-11T07:12:43.761231Z","steps":["trace[1278212823] 'process raft request' (duration: 126.656765ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:12:59.896572Z","caller":"traceutil/trace.go:171","msg":"trace[1899357662] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"110.141517ms","start":"2026-05-11T07:12:59.786404Z","end":"2026-05-11T07:12:59.896545Z","steps":["trace[1899357662] 'process raft request' (duration: 81.493649ms)","trace[1899357662] 'compare' (duration: 28.543706ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:12:59.899252Z","caller":"traceutil/trace.go:171","msg":"trace[381957485] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"108.498364ms","start":"2026-05-11T07:12:59.790742Z","end":"2026-05-11T07:12:59.899241Z","steps":["trace[381957485] 'process raft request' (duration: 108.367192ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:12:59.899641Z","caller":"traceutil/trace.go:171","msg":"trace[496798080] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"108.862659ms","start":"2026-05-11T07:12:59.790763Z","end":"2026-05-11T07:12:59.899626Z","steps":["trace[496798080] 'process raft request' (duration: 108.445244ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:12:59.899722Z","caller":"traceutil/trace.go:171","msg":"trace[870839731] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"108.914961ms","start":"2026-05-11T07:12:59.790796Z","end":"2026-05-11T07:12:59.899711Z","steps":["trace[870839731] 'process raft request' (duration: 108.600515ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:12:59.899787Z","caller":"traceutil/trace.go:171","msg":"trace[1030467803] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"105.443111ms","start":"2026-05-11T07:12:59.79432Z","end":"2026-05-11T07:12:59.899763Z","steps":["trace[1030467803] 'process raft request' (duration: 105.232207ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:12:59.899823Z","caller":"traceutil/trace.go:171","msg":"trace[617151789] transaction","detail":"{read_only:false; number_of_response:1; response_revision:477; }","duration":"104.119372ms","start":"2026-05-11T07:12:59.795656Z","end":"2026-05-11T07:12:59.899776Z","steps":["trace[617151789] 'process raft request' (duration: 103.939699ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:13:06.53979Z","caller":"traceutil/trace.go:171","msg":"trace[1245752252] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"159.507362ms","start":"2026-05-11T07:13:06.380252Z","end":"2026-05-11T07:13:06.539759Z","steps":["trace[1245752252] 'process raft request' (duration: 159.323999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:13:07.285279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.990402ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T07:13:07.28544Z","caller":"traceutil/trace.go:171","msg":"trace[279021186] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"628.153041ms","start":"2026-05-11T07:13:06.657267Z","end":"2026-05-11T07:13:07.28542Z","steps":["trace[279021186] 'process raft request' (duration: 231.931945ms)","trace[279021186] 'compare' (duration: 395.83116ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:13:07.285504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:13:06.657232Z","time spent":"628.239553ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:13:07.29273Z","caller":"traceutil/trace.go:171","msg":"trace[678094818] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"571.858924ms","start":"2026-05-11T07:13:06.720853Z","end":"2026-05-11T07:13:07.292712Z","steps":["trace[678094818] 'process raft request' (duration: 571.766543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:13:07.292829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:13:06.720817Z","time spent":"571.969426ms","remote":"127.0.0.1:57250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T07:13:23.666013Z","caller":"traceutil/trace.go:171","msg":"trace[474965119] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"306.661906ms","start":"2026-05-11T07:13:23.359312Z","end":"2026-05-11T07:13:23.665973Z","steps":["trace[474965119] 'process raft request' (duration: 306.441613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:13:23.666332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:13:23.359281Z","time spent":"306.851299ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:13:23.680824Z","caller":"traceutil/trace.go:171","msg":"trace[946226801] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"191.297379ms","start":"2026-05-11T07:13:23.489496Z","end":"2026-05-11T07:13:23.680794Z","steps":["trace[946226801] 'process raft request' (duration: 191.111315ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:15:36.178447Z","caller":"traceutil/trace.go:171","msg":"trace[604799760] linearizableReadLoop","detail":"{readStateIndex:1746; appliedIndex:1745; }","duration":"113.560545ms","start":"2026-05-11T07:15:36.06486Z","end":"2026-05-11T07:15:36.178421Z","steps":["trace[604799760] 'read index received' (duration: 113.391643ms)","trace[604799760] 'applied index is now lower than readState.Index' (duration: 167.652µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:15:36.178619Z","caller":"traceutil/trace.go:171","msg":"trace[286628908] transaction","detail":"{read_only:false; response_revision:1687; number_of_response:1; }","duration":"121.755591ms","start":"2026-05-11T07:15:36.056763Z","end":"2026-05-11T07:15:36.178519Z","steps":["trace[286628908] 'process raft request' (duration: 121.509188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:36.17878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.89455ms","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-05-11T07:15:36.178837Z","caller":"traceutil/trace.go:171","msg":"trace[1238201013] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1687; }","duration":"113.988642ms","start":"2026-05-11T07:15:36.064835Z","end":"2026-05-11T07:15:36.178824Z","steps":["trace[1238201013] 'agreement among raft nodes before linearized reading' (duration: 113.689648ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:36.575983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.096302ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T07:15:36.576389Z","caller":"traceutil/trace.go:171","msg":"trace[2019052963] transaction","detail":"{read_only:false; response_revision:1690; number_of_response:1; }","duration":"390.806825ms","start":"2026-05-11T07:15:36.185536Z","end":"2026-05-11T07:15:36.576343Z","steps":["trace[2019052963] 'process raft request' (duration: 390.537401ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:15:36.576399Z","caller":"traceutil/trace.go:171","msg":"trace[510956699] transaction","detail":"{read_only:false; response_revision:1691; number_of_response:1; }","duration":"390.612152ms","start":"2026-05-11T07:15:36.185762Z","end":"2026-05-11T07:15:36.576374Z","steps":["trace[510956699] 'process raft request' (duration: 390.375779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:36.576553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:36.185745Z","time spent":"390.732414ms","remote":"127.0.0.1:57192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":686,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:15:36.576495Z","caller":"traceutil/trace.go:171","msg":"trace[1574254841] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"390.851996ms","start":"2026-05-11T07:15:36.185621Z","end":"2026-05-11T07:15:36.576473Z","steps":["trace[1574254841] 'process raft request' (duration: 252.183116ms)","trace[1574254841] 'compare' (duration: 138.001831ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:15:36.576653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:36.185601Z","time spent":"391.009938ms","remote":"127.0.0.1:57192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":681,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:15:36.576916Z","caller":"traceutil/trace.go:171","msg":"trace[193223193] linearizableReadLoop","detail":"{readStateIndex:1752; appliedIndex:1747; }","duration":"242.46044ms","start":"2026-05-11T07:15:36.334408Z","end":"2026-05-11T07:15:36.576869Z","steps":["trace[193223193] 'read index received' (duration: 103.421686ms)","trace[193223193] 'applied index is now lower than readState.Index' (duration: 139.037904ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:15:36.577Z","caller":"traceutil/trace.go:171","msg":"trace[1140338535] transaction","detail":"{read_only:false; response_revision:1692; number_of_response:1; }","duration":"391.142378ms","start":"2026-05-11T07:15:36.185849Z","end":"2026-05-11T07:15:36.576991Z","steps":["trace[1140338535] 'process raft request' (duration: 390.328088ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:36.57713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.727673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:15:36.577165Z","caller":"traceutil/trace.go:171","msg":"trace[444742418] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1693; }","duration":"242.798993ms","start":"2026-05-11T07:15:36.334357Z","end":"2026-05-11T07:15:36.577156Z","steps":["trace[444742418] 'agreement among raft nodes before linearized reading' (duration: 242.720812ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:15:36.577337Z","caller":"traceutil/trace.go:171","msg":"trace[309369352] transaction","detail":"{read_only:false; response_revision:1693; number_of_response:1; }","duration":"388.777039ms","start":"2026-05-11T07:15:36.18855Z","end":"2026-05-11T07:15:36.577327Z","steps":["trace[309369352] 'process raft request' (duration: 387.673934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:36.577401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:36.188536Z","time spent":"388.830089ms","remote":"127.0.0.1:57514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6863,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T07:15:36.578383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:36.185837Z","time spent":"391.186779ms","remote":"127.0.0.1:57280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T07:15:36.576539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:36.185497Z","time spent":"390.965047ms","remote":"127.0.0.1:57280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1222,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:15:58.231363Z","caller":"traceutil/trace.go:171","msg":"trace[321786487] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"109.753878ms","start":"2026-05-11T07:15:58.121583Z","end":"2026-05-11T07:15:58.231337Z","steps":["trace[321786487] 'process raft request' (duration: 48.616148ms)","trace[321786487] 'compare' (duration: 61.030519ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:15:58.431349Z","caller":"traceutil/trace.go:171","msg":"trace[1779184202] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"194.472393ms","start":"2026-05-11T07:15:58.236845Z","end":"2026-05-11T07:15:58.431317Z","steps":["trace[1779184202] 'process raft request' (duration: 124.840933ms)","trace[1779184202] 'compare' (duration: 69.496379ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:15:58.916494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.100129ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T07:15:58.917037Z","caller":"traceutil/trace.go:171","msg":"trace[924283037] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"679.882658ms","start":"2026-05-11T07:15:58.237123Z","end":"2026-05-11T07:15:58.917006Z","steps":["trace[924283037] 'process raft request' (duration: 348.15015ms)","trace[924283037] 'compare' (duration: 330.884426ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:15:58.917186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:58.237113Z","time spent":"679.992879ms","remote":"127.0.0.1:57280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1528,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:15:58.917285Z","caller":"traceutil/trace.go:171","msg":"trace[430087783] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"680.07036ms","start":"2026-05-11T07:15:58.237176Z","end":"2026-05-11T07:15:58.917246Z","steps":["trace[430087783] 'process raft request' (duration: 679.738806ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:15:58.917302Z","caller":"traceutil/trace.go:171","msg":"trace[1011323757] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"679.407641ms","start":"2026-05-11T07:15:58.237863Z","end":"2026-05-11T07:15:58.917271Z","steps":["trace[1011323757] 'process raft request' (duration: 679.165158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:58.917439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:58.237163Z","time spent":"680.195172ms","remote":"127.0.0.1:57192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:15:58.9175Z","caller":"traceutil/trace.go:171","msg":"trace[274227530] linearizableReadLoop","detail":"{readStateIndex:2302; appliedIndex:2297; }","duration":"675.726675ms","start":"2026-05-11T07:15:58.24176Z","end":"2026-05-11T07:15:58.917487Z","steps":["trace[274227530] 'read index received' (duration: 119.939671ms)","trace[274227530] 'applied index is now lower than readState.Index' (duration: 555.785214ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:15:58.91756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:58.237844Z","time spent":"679.564183ms","remote":"127.0.0.1:57192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":976,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T07:15:58.917697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.934007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f31e1db5-9c4c-431f-8918-5e578d15a3e8\" ","response":"range_response_count:1 size:3616"} {"level":"info","ts":"2026-05-11T07:15:58.917671Z","caller":"traceutil/trace.go:171","msg":"trace[1787558578] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"676.14128ms","start":"2026-05-11T07:15:58.241428Z","end":"2026-05-11T07:15:58.91757Z","steps":["trace[1787558578] 'process raft request' (duration: 675.650984ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:15:58.917733Z","caller":"traceutil/trace.go:171","msg":"trace[34124516] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f31e1db5-9c4c-431f-8918-5e578d15a3e8; range_end:; response_count:1; response_revision:2207; }","duration":"676.000208ms","start":"2026-05-11T07:15:58.241721Z","end":"2026-05-11T07:15:58.917721Z","steps":["trace[34124516] 'agreement among raft nodes before linearized reading' (duration: 675.858096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:58.917776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:58.24171Z","time spent":"676.058778ms","remote":"127.0.0.1:57204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3639,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f31e1db5-9c4c-431f-8918-5e578d15a3e8\" "} {"level":"warn","ts":"2026-05-11T07:15:58.917863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.116009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-11T07:15:58.917902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.435898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eea70562-445d-4a7d-8de1-a114cca8649e\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-05-11T07:15:58.917944Z","caller":"traceutil/trace.go:171","msg":"trace[79621884] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eea70562-445d-4a7d-8de1-a114cca8649e; range_end:; response_count:1; response_revision:2207; }","duration":"582.497249ms","start":"2026-05-11T07:15:58.335433Z","end":"2026-05-11T07:15:58.91793Z","steps":["trace[79621884] 'agreement among raft nodes before linearized reading' (duration: 582.428318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:58.917989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:58.33542Z","time spent":"582.56147ms","remote":"127.0.0.1:57204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3766,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eea70562-445d-4a7d-8de1-a114cca8649e\" "} {"level":"warn","ts":"2026-05-11T07:15:58.918034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.504152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-11T07:15:58.918025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:58.241413Z","time spent":"676.360602ms","remote":"127.0.0.1:57204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:15:58.918069Z","caller":"traceutil/trace.go:171","msg":"trace[1846760518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2207; }","duration":"173.612864ms","start":"2026-05-11T07:15:58.744447Z","end":"2026-05-11T07:15:58.91806Z","steps":["trace[1846760518] 'agreement among raft nodes before linearized reading' (duration: 173.522733ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:15:58.917946Z","caller":"traceutil/trace.go:171","msg":"trace[400581778] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2207; }","duration":"177.21543ms","start":"2026-05-11T07:15:58.740695Z","end":"2026-05-11T07:15:58.917911Z","steps":["trace[400581778] 'agreement among raft nodes before linearized reading' (duration: 177.066758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:58.91823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.016779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-11T07:15:58.918357Z","caller":"traceutil/trace.go:171","msg":"trace[1350096554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2207; }","duration":"601.182311ms","start":"2026-05-11T07:15:58.317155Z","end":"2026-05-11T07:15:58.918337Z","steps":["trace[1350096554] 'agreement among raft nodes before linearized reading' (duration: 600.530532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:58.918276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.52777ms","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-05-11T07:15:58.918463Z","caller":"traceutil/trace.go:171","msg":"trace[1621349742] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2207; }","duration":"261.773634ms","start":"2026-05-11T07:15:58.656674Z","end":"2026-05-11T07:15:58.918448Z","steps":["trace[1621349742] 'agreement among raft nodes before linearized reading' (duration: 261.240346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:58.918558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:15:58.317136Z","time spent":"601.346243ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-11T07:15:59.137997Z","caller":"traceutil/trace.go:171","msg":"trace[2127890312] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"211.491923ms","start":"2026-05-11T07:15:58.926473Z","end":"2026-05-11T07:15:59.137965Z","steps":["trace[2127890312] 'process raft request' (duration: 211.419402ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:15:59.138016Z","caller":"traceutil/trace.go:171","msg":"trace[1272174542] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"214.570323ms","start":"2026-05-11T07:15:58.923409Z","end":"2026-05-11T07:15:59.137979Z","steps":["trace[1272174542] 'process raft request' (duration: 132.830167ms)","trace[1272174542] 'compare' (duration: 81.536264ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:15:59.138317Z","caller":"traceutil/trace.go:171","msg":"trace[806411199] linearizableReadLoop","detail":"{readStateIndex:2306; appliedIndex:2302; }","duration":"173.415752ms","start":"2026-05-11T07:15:58.964876Z","end":"2026-05-11T07:15:59.138291Z","steps":["trace[806411199] 'read index received' (duration: 91.375931ms)","trace[806411199] 'applied index is now lower than readState.Index' (duration: 82.037561ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:15:59.138338Z","caller":"traceutil/trace.go:171","msg":"trace[13829651] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"211.637845ms","start":"2026-05-11T07:15:58.926686Z","end":"2026-05-11T07:15:59.138324Z","steps":["trace[13829651] 'process raft request' (duration: 211.24451ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:15:59.138403Z","caller":"traceutil/trace.go:171","msg":"trace[852603264] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"190.234019ms","start":"2026-05-11T07:15:58.948141Z","end":"2026-05-11T07:15:59.138375Z","steps":["trace[852603264] 'process raft request' (duration: 189.985646ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:15:59.13852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.635704ms","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-05-11T07:15:59.138564Z","caller":"traceutil/trace.go:171","msg":"trace[654547588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2211; }","duration":"173.729135ms","start":"2026-05-11T07:15:58.964824Z","end":"2026-05-11T07:15:59.138553Z","steps":["trace[654547588] 'agreement among raft nodes before linearized reading' (duration: 173.554753ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:14.737722Z","caller":"traceutil/trace.go:171","msg":"trace[214295960] transaction","detail":"{read_only:false; response_revision:2354; number_of_response:1; }","duration":"143.496486ms","start":"2026-05-11T07:16:14.594194Z","end":"2026-05-11T07:16:14.73769Z","steps":["trace[214295960] 'process raft request' (duration: 143.283793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:15.150473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.792783ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-11T07:16:15.150597Z","caller":"traceutil/trace.go:171","msg":"trace[1060582503] linearizableReadLoop","detail":"{readStateIndex:2454; appliedIndex:2453; }","duration":"105.09942ms","start":"2026-05-11T07:16:15.045479Z","end":"2026-05-11T07:16:15.150579Z","steps":["trace[1060582503] 'read index received' (duration: 39.691µs)","trace[1060582503] 'applied index is now lower than readState.Index' (duration: 105.058189ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:16:15.150774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.286782ms","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-05-11T07:16:15.150822Z","caller":"traceutil/trace.go:171","msg":"trace[267063972] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2355; }","duration":"105.343702ms","start":"2026-05-11T07:16:15.045466Z","end":"2026-05-11T07:16:15.15081Z","steps":["trace[267063972] 'agreement among raft nodes before linearized reading' (duration: 105.17008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:15.479531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.809596ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T07:16:15.479784Z","caller":"traceutil/trace.go:171","msg":"trace[1881118216] transaction","detail":"{read_only:false; response_revision:2358; number_of_response:1; }","duration":"142.270009ms","start":"2026-05-11T07:16:15.337491Z","end":"2026-05-11T07:16:15.479761Z","steps":["trace[1881118216] 'process raft request' (duration: 142.191018ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:15.47981Z","caller":"traceutil/trace.go:171","msg":"trace[730910030] transaction","detail":"{read_only:false; response_revision:2357; number_of_response:1; }","duration":"156.039218ms","start":"2026-05-11T07:16:15.323728Z","end":"2026-05-11T07:16:15.479767Z","steps":["trace[730910030] 'process raft request' (duration: 26.837047ms)","trace[730910030] 'compare' (duration: 128.580303ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:16:15.479817Z","caller":"traceutil/trace.go:171","msg":"trace[895125760] linearizableReadLoop","detail":"{readStateIndex:2456; appliedIndex:2455; }","duration":"147.249805ms","start":"2026-05-11T07:16:15.332531Z","end":"2026-05-11T07:16:15.479781Z","steps":["trace[895125760] 'read index received' (duration: 18.091704ms)","trace[895125760] 'applied index is now lower than readState.Index' (duration: 129.151511ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:16:15.480127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.777264ms","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-05-11T07:16:15.480187Z","caller":"traceutil/trace.go:171","msg":"trace[1704081633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2358; }","duration":"182.875595ms","start":"2026-05-11T07:16:15.2973Z","end":"2026-05-11T07:16:15.480175Z","steps":["trace[1704081633] 'agreement among raft nodes before linearized reading' (duration: 182.693692ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:15.480167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.584331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-11T07:16:15.480341Z","caller":"traceutil/trace.go:171","msg":"trace[1100877619] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2358; }","duration":"182.777145ms","start":"2026-05-11T07:16:15.297521Z","end":"2026-05-11T07:16:15.480298Z","steps":["trace[1100877619] 'agreement among raft nodes before linearized reading' (duration: 182.317268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:15.480641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.952867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-11T07:16:15.480703Z","caller":"traceutil/trace.go:171","msg":"trace[1578808878] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2358; }","duration":"183.079859ms","start":"2026-05-11T07:16:15.297612Z","end":"2026-05-11T07:16:15.480692Z","steps":["trace[1578808878] 'agreement among raft nodes before linearized reading' (duration: 182.897907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:15.493097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.333016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:16:15.493159Z","caller":"traceutil/trace.go:171","msg":"trace[1441533900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2359; }","duration":"157.461207ms","start":"2026-05-11T07:16:15.335684Z","end":"2026-05-11T07:16:15.493145Z","steps":["trace[1441533900] 'agreement among raft nodes before linearized reading' (duration: 157.340935ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:15.678339Z","caller":"traceutil/trace.go:171","msg":"trace[1984501731] transaction","detail":"{read_only:false; response_revision:2362; number_of_response:1; }","duration":"193.096648ms","start":"2026-05-11T07:16:15.485229Z","end":"2026-05-11T07:16:15.678326Z","steps":["trace[1984501731] 'process raft request' (duration: 193.011037ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:15.678471Z","caller":"traceutil/trace.go:171","msg":"trace[1278974121] transaction","detail":"{read_only:false; response_revision:2361; number_of_response:1; }","duration":"193.616554ms","start":"2026-05-11T07:16:15.484843Z","end":"2026-05-11T07:16:15.67846Z","steps":["trace[1278974121] 'process raft request' (duration: 193.35331ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:15.678542Z","caller":"traceutil/trace.go:171","msg":"trace[329202971] linearizableReadLoop","detail":"{readStateIndex:2461; appliedIndex:2458; }","duration":"184.757629ms","start":"2026-05-11T07:16:15.49377Z","end":"2026-05-11T07:16:15.678528Z","steps":["trace[329202971] 'read index received' (duration: 105.92769ms)","trace[329202971] 'applied index is now lower than readState.Index' (duration: 78.828719ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:16:15.678625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.844981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:16:15.678652Z","caller":"traceutil/trace.go:171","msg":"trace[935949957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2364; }","duration":"184.915482ms","start":"2026-05-11T07:16:15.493728Z","end":"2026-05-11T07:16:15.678644Z","steps":["trace[935949957] 'agreement among raft nodes before linearized reading' (duration: 184.855941ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:15.678705Z","caller":"traceutil/trace.go:171","msg":"trace[2023228319] transaction","detail":"{read_only:false; response_revision:2363; number_of_response:1; }","duration":"176.369461ms","start":"2026-05-11T07:16:15.502327Z","end":"2026-05-11T07:16:15.678696Z","steps":["trace[2023228319] 'process raft request' (duration: 175.947165ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:15.678297Z","caller":"traceutil/trace.go:171","msg":"trace[534000744] transaction","detail":"{read_only:false; response_revision:2360; number_of_response:1; }","duration":"193.577373ms","start":"2026-05-11T07:16:15.484691Z","end":"2026-05-11T07:16:15.678268Z","steps":["trace[534000744] 'process raft request' (duration: 115.125959ms)","trace[534000744] 'compare' (duration: 78.198021ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:16:21.690326Z","caller":"traceutil/trace.go:171","msg":"trace[1479047867] transaction","detail":"{read_only:false; response_revision:2412; number_of_response:1; }","duration":"185.691483ms","start":"2026-05-11T07:16:21.504605Z","end":"2026-05-11T07:16:21.690296Z","steps":["trace[1479047867] 'process raft request' (duration: 185.519421ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:21.706938Z","caller":"traceutil/trace.go:171","msg":"trace[871601963] transaction","detail":"{read_only:false; response_revision:2413; number_of_response:1; }","duration":"176.112949ms","start":"2026-05-11T07:16:21.530801Z","end":"2026-05-11T07:16:21.706914Z","steps":["trace[871601963] 'process raft request' (duration: 175.941847ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:21.70716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.20962ms","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-05-11T07:16:21.707226Z","caller":"traceutil/trace.go:171","msg":"trace[810215090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2413; }","duration":"176.317181ms","start":"2026-05-11T07:16:21.530893Z","end":"2026-05-11T07:16:21.707211Z","steps":["trace[810215090] 'agreement among raft nodes before linearized reading' (duration: 176.086368ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:21.707286Z","caller":"traceutil/trace.go:171","msg":"trace[794553344] linearizableReadLoop","detail":"{readStateIndex:2514; appliedIndex:2513; }","duration":"175.959497ms","start":"2026-05-11T07:16:21.530925Z","end":"2026-05-11T07:16:21.706884Z","steps":["trace[794553344] 'read index received' (duration: 159.629605ms)","trace[794553344] 'applied index is now lower than readState.Index' (duration: 16.329002ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:16:21.707397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.856469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:16:21.707428Z","caller":"traceutil/trace.go:171","msg":"trace[971603667] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2413; }","duration":"166.918929ms","start":"2026-05-11T07:16:21.540498Z","end":"2026-05-11T07:16:21.707417Z","steps":["trace[971603667] 'agreement among raft nodes before linearized reading' (duration: 166.861878ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:21.828379Z","caller":"traceutil/trace.go:171","msg":"trace[2065157282] transaction","detail":"{read_only:false; response_revision:2414; number_of_response:1; }","duration":"117.984256ms","start":"2026-05-11T07:16:21.710355Z","end":"2026-05-11T07:16:21.82834Z","steps":["trace[2065157282] 'process raft request' (duration: 111.916448ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:21.832467Z","caller":"traceutil/trace.go:171","msg":"trace[1078870084] transaction","detail":"{read_only:false; response_revision:2415; number_of_response:1; }","duration":"108.324771ms","start":"2026-05-11T07:16:21.724117Z","end":"2026-05-11T07:16:21.832442Z","steps":["trace[1078870084] 'process raft request' (duration: 108.001457ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:42.004683Z","caller":"traceutil/trace.go:171","msg":"trace[372968275] transaction","detail":"{read_only:false; response_revision:2533; number_of_response:1; }","duration":"222.47729ms","start":"2026-05-11T07:16:41.782162Z","end":"2026-05-11T07:16:42.004655Z","steps":["trace[372968275] 'process raft request' (duration: 222.320538ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:42.043098Z","caller":"traceutil/trace.go:171","msg":"trace[1265067893] transaction","detail":"{read_only:false; response_revision:2534; number_of_response:1; }","duration":"131.650184ms","start":"2026-05-11T07:16:41.911425Z","end":"2026-05-11T07:16:42.043075Z","steps":["trace[1265067893] 'process raft request' (duration: 131.527342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:42.043434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.220127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-11T07:16:42.04353Z","caller":"traceutil/trace.go:171","msg":"trace[202214792] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2534; }","duration":"100.367809ms","start":"2026-05-11T07:16:41.943147Z","end":"2026-05-11T07:16:42.043515Z","steps":["trace[202214792] 'agreement among raft nodes before linearized reading' (duration: 100.141236ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:42.16166Z","caller":"traceutil/trace.go:171","msg":"trace[564369878] transaction","detail":"{read_only:false; response_revision:2536; number_of_response:1; }","duration":"112.822651ms","start":"2026-05-11T07:16:42.048808Z","end":"2026-05-11T07:16:42.161631Z","steps":["trace[564369878] 'process raft request' (duration: 112.620239ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:42.162106Z","caller":"traceutil/trace.go:171","msg":"trace[1457855335] transaction","detail":"{read_only:false; response_revision:2537; number_of_response:1; }","duration":"113.204706ms","start":"2026-05-11T07:16:42.048885Z","end":"2026-05-11T07:16:42.16209Z","steps":["trace[1457855335] 'process raft request' (duration: 112.702289ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:42.162247Z","caller":"traceutil/trace.go:171","msg":"trace[785798727] transaction","detail":"{read_only:false; response_revision:2538; number_of_response:1; }","duration":"113.302216ms","start":"2026-05-11T07:16:42.04893Z","end":"2026-05-11T07:16:42.162233Z","steps":["trace[785798727] 'process raft request' (duration: 112.933582ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:42.16215Z","caller":"traceutil/trace.go:171","msg":"trace[590987933] transaction","detail":"{read_only:false; response_revision:2539; number_of_response:1; }","duration":"112.01452ms","start":"2026-05-11T07:16:42.050107Z","end":"2026-05-11T07:16:42.162121Z","steps":["trace[590987933] 'process raft request' (duration: 111.942339ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:44.099478Z","caller":"traceutil/trace.go:171","msg":"trace[715177915] transaction","detail":"{read_only:false; response_revision:2543; number_of_response:1; }","duration":"339.87846ms","start":"2026-05-11T07:16:43.759571Z","end":"2026-05-11T07:16:44.099449Z","steps":["trace[715177915] 'process raft request' (duration: 339.720838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:44.099694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:16:43.759541Z","time spent":"340.021111ms","remote":"127.0.0.1:57092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T07:16:44.563516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.108581ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T07:16:44.564032Z","caller":"traceutil/trace.go:171","msg":"trace[1484199750] transaction","detail":"{read_only:false; response_revision:2544; number_of_response:1; }","duration":"779.209978ms","start":"2026-05-11T07:16:43.784786Z","end":"2026-05-11T07:16:44.563996Z","steps":["trace[1484199750] 'process raft request' (duration: 462.553409ms)","trace[1484199750] 'compare' (duration: 315.942349ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:16:44.564271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.193764ms","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-05-11T07:16:44.564298Z","caller":"traceutil/trace.go:171","msg":"trace[1147434309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2546; }","duration":"442.224715ms","start":"2026-05-11T07:16:44.122068Z","end":"2026-05-11T07:16:44.564292Z","steps":["trace[1147434309] 'agreement among raft nodes before linearized reading' (duration: 442.104853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:44.564322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:16:44.121989Z","time spent":"442.327896ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-11T07:16:44.564129Z","caller":"traceutil/trace.go:171","msg":"trace[1600867323] transaction","detail":"{read_only:false; response_revision:2546; number_of_response:1; }","duration":"515.616915ms","start":"2026-05-11T07:16:44.048494Z","end":"2026-05-11T07:16:44.564111Z","steps":["trace[1600867323] 'process raft request' (duration: 515.496573ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:44.564103Z","caller":"traceutil/trace.go:171","msg":"trace[2116303868] transaction","detail":"{read_only:false; response_revision:2545; number_of_response:1; }","duration":"552.412012ms","start":"2026-05-11T07:16:44.011664Z","end":"2026-05-11T07:16:44.564076Z","steps":["trace[2116303868] 'process raft request' (duration: 551.947555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:44.564696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:16:43.784764Z","time spent":"779.709104ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T07:16:44.564781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:16:44.011638Z","time spent":"553.0972ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:16:44.564059Z","caller":"traceutil/trace.go:171","msg":"trace[1564058844] linearizableReadLoop","detail":"{readStateIndex:2651; appliedIndex:2648; }","duration":"441.956422ms","start":"2026-05-11T07:16:44.122088Z","end":"2026-05-11T07:16:44.564045Z","steps":["trace[1564058844] 'read index received' (duration: 125.237242ms)","trace[1564058844] 'applied index is now lower than readState.Index' (duration: 316.71845ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:16:44.565129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.677962ms","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-05-11T07:16:44.565137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.57136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-11T07:16:44.565174Z","caller":"traceutil/trace.go:171","msg":"trace[351786155] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2546; }","duration":"201.770883ms","start":"2026-05-11T07:16:44.363388Z","end":"2026-05-11T07:16:44.565159Z","steps":["trace[351786155] 'agreement among raft nodes before linearized reading' (duration: 201.61802ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:16:44.565181Z","caller":"traceutil/trace.go:171","msg":"trace[646557986] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2546; }","duration":"398.667061ms","start":"2026-05-11T07:16:44.166501Z","end":"2026-05-11T07:16:44.565168Z","steps":["trace[646557986] 'agreement among raft nodes before linearized reading' (duration: 398.503308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:44.565357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:16:44.166481Z","time spent":"398.862493ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-11T07:16:44.565405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.308227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-11T07:16:44.565423Z","caller":"traceutil/trace.go:171","msg":"trace[295223253] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2546; }","duration":"398.344387ms","start":"2026-05-11T07:16:44.167073Z","end":"2026-05-11T07:16:44.565417Z","steps":["trace[295223253] 'agreement among raft nodes before linearized reading' (duration: 398.290427ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:44.565437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:16:44.167064Z","time spent":"398.369458ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-11T07:16:44.565549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.175825ms","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-05-11T07:16:44.565577Z","caller":"traceutil/trace.go:171","msg":"trace[231385808] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2546; }","duration":"398.218506ms","start":"2026-05-11T07:16:44.167352Z","end":"2026-05-11T07:16:44.565571Z","steps":["trace[231385808] 'agreement among raft nodes before linearized reading' (duration: 398.156916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:44.565595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:16:44.167346Z","time spent":"398.244996ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-11T07:16:44.565687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.053626ms","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-05-11T07:16:44.565787Z","caller":"traceutil/trace.go:171","msg":"trace[64885158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2546; }","duration":"399.192288ms","start":"2026-05-11T07:16:44.166573Z","end":"2026-05-11T07:16:44.565766Z","steps":["trace[64885158] 'agreement among raft nodes before linearized reading' (duration: 398.909074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:44.565828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.774558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18ae71943fc5b967\" ","response":"range_response_count:1 size:846"} {"level":"warn","ts":"2026-05-11T07:16:44.565851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:16:44.166556Z","time spent":"399.280138ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-11T07:16:44.565872Z","caller":"traceutil/trace.go:171","msg":"trace[1001015742] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18ae71943fc5b967; range_end:; response_count:1; response_revision:2546; }","duration":"166.86991ms","start":"2026-05-11T07:16:44.398989Z","end":"2026-05-11T07:16:44.565859Z","steps":["trace[1001015742] 'agreement among raft nodes before linearized reading' (duration: 166.181221ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:16:44.566359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:16:44.048463Z","time spent":"516.061371ms","remote":"127.0.0.1:57276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:18:04.822299Z","caller":"traceutil/trace.go:171","msg":"trace[2115040667] transaction","detail":"{read_only:false; response_revision:3085; number_of_response:1; }","duration":"199.843114ms","start":"2026-05-11T07:18:04.62242Z","end":"2026-05-11T07:18:04.822263Z","steps":["trace[2115040667] 'process raft request' (duration: 186.506741ms)","trace[2115040667] 'compare' (duration: 12.988725ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:18:05.118469Z","caller":"traceutil/trace.go:171","msg":"trace[859123584] transaction","detail":"{read_only:false; response_revision:3087; number_of_response:1; }","duration":"239.165804ms","start":"2026-05-11T07:18:04.879286Z","end":"2026-05-11T07:18:05.118452Z","steps":["trace[859123584] 'process raft request' (duration: 239.049871ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:05.128584Z","caller":"traceutil/trace.go:171","msg":"trace[1470096124] transaction","detail":"{read_only:false; response_revision:3088; number_of_response:1; }","duration":"148.374111ms","start":"2026-05-11T07:18:04.980177Z","end":"2026-05-11T07:18:05.128552Z","steps":["trace[1470096124] 'process raft request' (duration: 148.261687ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:05.128659Z","caller":"traceutil/trace.go:171","msg":"trace[1587387413] transaction","detail":"{read_only:false; response_revision:3089; number_of_response:1; }","duration":"145.480347ms","start":"2026-05-11T07:18:04.983147Z","end":"2026-05-11T07:18:05.128627Z","steps":["trace[1587387413] 'process raft request' (duration: 145.353224ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:05.145848Z","caller":"traceutil/trace.go:171","msg":"trace[1214580765] linearizableReadLoop","detail":"{readStateIndex:3211; appliedIndex:3209; }","duration":"141.064802ms","start":"2026-05-11T07:18:05.004686Z","end":"2026-05-11T07:18:05.145751Z","steps":["trace[1214580765] 'read index received' (duration: 113.883166ms)","trace[1214580765] 'applied index is now lower than readState.Index' (duration: 27.180246ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:18:05.145997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.291998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-11T07:18:05.146068Z","caller":"traceutil/trace.go:171","msg":"trace[1230844746] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3089; }","duration":"141.402981ms","start":"2026-05-11T07:18:05.00465Z","end":"2026-05-11T07:18:05.146053Z","steps":["trace[1230844746] 'agreement among raft nodes before linearized reading' (duration: 141.211746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:18:05.146089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.448165ms","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-05-11T07:18:05.146127Z","caller":"traceutil/trace.go:171","msg":"trace[778708839] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3089; }","duration":"138.519107ms","start":"2026-05-11T07:18:05.007597Z","end":"2026-05-11T07:18:05.146116Z","steps":["trace[778708839] 'agreement among raft nodes before linearized reading' (duration: 138.361303ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:18:05.146146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.469566ms","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-05-11T07:18:05.146203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.843746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-11T07:18:05.146224Z","caller":"traceutil/trace.go:171","msg":"trace[989109397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3089; }","duration":"113.548988ms","start":"2026-05-11T07:18:05.032659Z","end":"2026-05-11T07:18:05.146208Z","steps":["trace[989109397] 'agreement among raft nodes before linearized reading' (duration: 113.379214ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:05.146243Z","caller":"traceutil/trace.go:171","msg":"trace[2022867736] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3089; }","duration":"133.918358ms","start":"2026-05-11T07:18:05.012316Z","end":"2026-05-11T07:18:05.146234Z","steps":["trace[2022867736] 'agreement among raft nodes before linearized reading' (duration: 133.781875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:18:05.146334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.303933ms","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-05-11T07:18:05.146391Z","caller":"traceutil/trace.go:171","msg":"trace[1299057574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3089; }","duration":"124.396585ms","start":"2026-05-11T07:18:05.021978Z","end":"2026-05-11T07:18:05.146375Z","steps":["trace[1299057574] 'agreement among raft nodes before linearized reading' (duration: 124.099058ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:17.37914Z","caller":"traceutil/trace.go:171","msg":"trace[89370609] linearizableReadLoop","detail":"{readStateIndex:3305; appliedIndex:3304; }","duration":"416.638769ms","start":"2026-05-11T07:18:16.962477Z","end":"2026-05-11T07:18:17.379116Z","steps":["trace[89370609] 'read index received' (duration: 416.424124ms)","trace[89370609] 'applied index is now lower than readState.Index' (duration: 213.675µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:18:17.379248Z","caller":"traceutil/trace.go:171","msg":"trace[295732543] transaction","detail":"{read_only:false; response_revision:3179; number_of_response:1; }","duration":"472.103027ms","start":"2026-05-11T07:18:16.907103Z","end":"2026-05-11T07:18:17.379206Z","steps":["trace[295732543] 'process raft request' (duration: 471.81771ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:18:17.379368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.870954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T07:18:17.379408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:18:16.907079Z","time spent":"472.248991ms","remote":"127.0.0.1:57204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10669,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T07:18:17.379444Z","caller":"traceutil/trace.go:171","msg":"trace[1689333073] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:3179; }","duration":"416.996027ms","start":"2026-05-11T07:18:16.962428Z","end":"2026-05-11T07:18:17.379424Z","steps":["trace[1689333073] 'agreement among raft nodes before linearized reading' (duration: 416.835993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:18:17.379495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T07:18:16.962407Z","time spent":"417.073419ms","remote":"127.0.0.1:37132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-05-11T07:18:17.413214Z","caller":"traceutil/trace.go:171","msg":"trace[805396310] transaction","detail":"{read_only:false; response_revision:3181; number_of_response:1; }","duration":"224.990097ms","start":"2026-05-11T07:18:17.188201Z","end":"2026-05-11T07:18:17.413192Z","steps":["trace[805396310] 'process raft request' (duration: 224.916426ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:17.41325Z","caller":"traceutil/trace.go:171","msg":"trace[1114187026] transaction","detail":"{read_only:false; response_revision:3180; number_of_response:1; }","duration":"236.101371ms","start":"2026-05-11T07:18:17.177103Z","end":"2026-05-11T07:18:17.413204Z","steps":["trace[1114187026] 'process raft request' (duration: 235.847465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:18:17.413617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.86214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-11T07:18:17.413607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.215586ms","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-05-11T07:18:17.413668Z","caller":"traceutil/trace.go:171","msg":"trace[1913858525] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3182; }","duration":"134.953463ms","start":"2026-05-11T07:18:17.278702Z","end":"2026-05-11T07:18:17.413655Z","steps":["trace[1913858525] 'agreement among raft nodes before linearized reading' (duration: 134.705877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:18:17.413658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.651919ms","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-05-11T07:18:17.413687Z","caller":"traceutil/trace.go:171","msg":"trace[2047283373] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3182; }","duration":"141.344539ms","start":"2026-05-11T07:18:17.272323Z","end":"2026-05-11T07:18:17.413667Z","steps":["trace[2047283373] 'agreement among raft nodes before linearized reading' (duration: 141.092433ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:17.413679Z","caller":"traceutil/trace.go:171","msg":"trace[1417937313] transaction","detail":"{read_only:false; response_revision:3182; number_of_response:1; }","duration":"185.092116ms","start":"2026-05-11T07:18:17.228568Z","end":"2026-05-11T07:18:17.41366Z","steps":["trace[1417937313] 'process raft request' (duration: 184.590153ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:17.413739Z","caller":"traceutil/trace.go:171","msg":"trace[1961378517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3182; }","duration":"137.777702ms","start":"2026-05-11T07:18:17.275945Z","end":"2026-05-11T07:18:17.413723Z","steps":["trace[1961378517] 'agreement among raft nodes before linearized reading' (duration: 137.592078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:18:17.415224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.198594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-11T07:18:17.415752Z","caller":"traceutil/trace.go:171","msg":"trace[1020148778] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3182; }","duration":"158.790408ms","start":"2026-05-11T07:18:17.256938Z","end":"2026-05-11T07:18:17.415728Z","steps":["trace[1020148778] 'agreement among raft nodes before linearized reading' (duration: 156.507993ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:17.526216Z","caller":"traceutil/trace.go:171","msg":"trace[216869279] transaction","detail":"{read_only:false; response_revision:3188; number_of_response:1; }","duration":"107.749132ms","start":"2026-05-11T07:18:17.418443Z","end":"2026-05-11T07:18:17.526192Z","steps":["trace[216869279] 'process raft request' (duration: 107.623619ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:17.526279Z","caller":"traceutil/trace.go:171","msg":"trace[2066528282] transaction","detail":"{read_only:false; response_revision:3187; number_of_response:1; }","duration":"107.848044ms","start":"2026-05-11T07:18:17.418393Z","end":"2026-05-11T07:18:17.526241Z","steps":["trace[2066528282] 'process raft request' (duration: 62.9712ms)","trace[2066528282] 'compare' (duration: 44.512465ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:18:17.526525Z","caller":"traceutil/trace.go:171","msg":"trace[907980913] transaction","detail":"{read_only:false; response_revision:3189; number_of_response:1; }","duration":"108.038339ms","start":"2026-05-11T07:18:17.418474Z","end":"2026-05-11T07:18:17.526513Z","steps":["trace[907980913] 'process raft request' (duration: 107.652939ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:17.526638Z","caller":"traceutil/trace.go:171","msg":"trace[844716570] transaction","detail":"{read_only:false; response_revision:3190; number_of_response:1; }","duration":"107.616028ms","start":"2026-05-11T07:18:17.41901Z","end":"2026-05-11T07:18:17.526626Z","steps":["trace[844716570] 'process raft request' (duration: 107.404413ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:17.526755Z","caller":"traceutil/trace.go:171","msg":"trace[261023286] transaction","detail":"{read_only:false; response_revision:3191; number_of_response:1; }","duration":"106.996363ms","start":"2026-05-11T07:18:17.419744Z","end":"2026-05-11T07:18:17.52674Z","steps":["trace[261023286] 'process raft request' (duration: 106.802118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:18:17.526815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.259654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T07:18:17.526892Z","caller":"traceutil/trace.go:171","msg":"trace[36123086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3191; }","duration":"112.358526ms","start":"2026-05-11T07:18:17.414511Z","end":"2026-05-11T07:18:17.526869Z","steps":["trace[36123086] 'agreement among raft nodes before linearized reading' (duration: 112.100149ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:18:17.720709Z","caller":"traceutil/trace.go:171","msg":"trace[951060741] transaction","detail":"{read_only:false; response_revision:3193; number_of_response:1; }","duration":"155.171479ms","start":"2026-05-11T07:18:17.565512Z","end":"2026-05-11T07:18:17.720683Z","steps":["trace[951060741] 'process raft request' (duration: 83.244489ms)","trace[951060741] 'compare' (duration: 71.740516ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:18:51.773569Z","caller":"traceutil/trace.go:171","msg":"trace[1986356062] transaction","detail":"{read_only:false; response_revision:3485; number_of_response:1; }","duration":"122.767313ms","start":"2026-05-11T07:18:51.650774Z","end":"2026-05-11T07:18:51.773542Z","steps":["trace[1986356062] 'process raft request' (duration: 115.822889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:19:05.862329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.97366ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T07:19:05.862465Z","caller":"traceutil/trace.go:171","msg":"trace[270016415] transaction","detail":"{read_only:false; response_revision:3587; number_of_response:1; }","duration":"139.026505ms","start":"2026-05-11T07:19:05.723376Z","end":"2026-05-11T07:19:05.862403Z","steps":["trace[270016415] 'compare' (duration: 130.603052ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:19:09.517869Z","caller":"traceutil/trace.go:171","msg":"trace[1908992171] transaction","detail":"{read_only:false; response_revision:3620; number_of_response:1; }","duration":"101.300822ms","start":"2026-05-11T07:19:09.416543Z","end":"2026-05-11T07:19:09.517844Z","steps":["trace[1908992171] 'process raft request' (duration: 91.529834ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:22:36.771914Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2836} {"level":"info","ts":"2026-05-11T07:22:36.833379Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2836,"took":"60.618213ms","hash":2399983883,"current-db-size-bytes":38408192,"current-db-size":"38 MB","current-db-size-in-use-bytes":14536704,"current-db-size-in-use":"14 MB"} {"level":"info","ts":"2026-05-11T07:22:36.833449Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2399983883,"revision":2836,"compact-revision":-1} {"level":"info","ts":"2026-05-11T07:25:03.704793Z","caller":"traceutil/trace.go:171","msg":"trace[1724577297] transaction","detail":"{read_only:false; response_revision:6719; number_of_response:1; }","duration":"140.814758ms","start":"2026-05-11T07:25:03.563952Z","end":"2026-05-11T07:25:03.704766Z","steps":["trace[1724577297] 'process raft request' (duration: 140.644395ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:25:09.082374Z","caller":"traceutil/trace.go:171","msg":"trace[2122622256] linearizableReadLoop","detail":"{readStateIndex:6997; appliedIndex:6996; }","duration":"131.952003ms","start":"2026-05-11T07:25:08.950404Z","end":"2026-05-11T07:25:09.082356Z","steps":["trace[2122622256] 'read index received' (duration: 131.867922ms)","trace[2122622256] 'applied index is now lower than readState.Index' (duration: 83.431µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T07:25:09.082432Z","caller":"traceutil/trace.go:171","msg":"trace[1931784899] transaction","detail":"{read_only:false; response_revision:6747; number_of_response:1; }","duration":"134.513122ms","start":"2026-05-11T07:25:08.94788Z","end":"2026-05-11T07:25:09.082393Z","steps":["trace[1931784899] 'process raft request' (duration: 134.361369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T07:25:09.082544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.126376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/local-path-provisioner\" ","response":"range_response_count:1 size:1106"} {"level":"info","ts":"2026-05-11T07:25:09.082569Z","caller":"traceutil/trace.go:171","msg":"trace[1655783477] range","detail":"{range_begin:/registry/clusterroles/local-path-provisioner; range_end:; response_count:1; response_revision:6747; }","duration":"132.191206ms","start":"2026-05-11T07:25:08.950372Z","end":"2026-05-11T07:25:09.082563Z","steps":["trace[1655783477] 'agreement among raft nodes before linearized reading' (duration: 132.101015ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:25:09.232182Z","caller":"traceutil/trace.go:171","msg":"trace[973924027] linearizableReadLoop","detail":"{readStateIndex:6998; appliedIndex:6997; }","duration":"143.961253ms","start":"2026-05-11T07:25:09.088198Z","end":"2026-05-11T07:25:09.232159Z","steps":["trace[973924027] 'read index received' (duration: 113.039131ms)","trace[973924027] 'applied index is now lower than readState.Index' (duration: 30.921272ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T07:25:09.232413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.207397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/kubeadm:get-nodes\" ","response":"range_response_count:1 size:305"} {"level":"info","ts":"2026-05-11T07:25:09.232476Z","caller":"traceutil/trace.go:171","msg":"trace[610406404] range","detail":"{range_begin:/registry/clusterroles/kubeadm:get-nodes; range_end:; response_count:1; response_revision:6748; }","duration":"144.298718ms","start":"2026-05-11T07:25:09.088162Z","end":"2026-05-11T07:25:09.23246Z","steps":["trace[610406404] 'agreement among raft nodes before linearized reading' (duration: 144.169106ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T07:25:09.232546Z","caller":"traceutil/trace.go:171","msg":"trace[1590158339] transaction","detail":"{read_only:false; response_revision:6748; number_of_response:1; }","duration":"144.664564ms","start":"2026-05-11T07:25:09.08779Z","end":"2026-05-11T07:25:09.232454Z","steps":["trace[1590158339] 'process raft request' (duration: 113.515278ms)","trace[1590158339] 'compare' (duration: 30.76063ms)"],"step_count":2}