{"level":"warn","ts":"2026-08-20T06:09:11.095927Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-20T06:09:11.096022Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-08-20T06:09:11.096116Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-20T06:09:11.09613Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-08-20T06:09:11.096146Z","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-08-20T06:09:11.09672Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-08-20T06:09:11.096786Z","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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-08-20T06:09:11.100584Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.561007ms"} {"level":"info","ts":"2026-08-20T06:09:11.107656Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-08-20T06:09:11.10778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-08-20T06:09:11.107819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-08-20T06:09:11.107838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-20T06:09:11.107857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-08-20T06:09:11.107918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-08-20T06:09:11.115494Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-20T06:09:11.116833Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-20T06:09:11.11773Z","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-08-20T06:09:11.122389Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-20T06:09:11.122651Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-20T06:09:11.122876Z","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-08-20T06:09:11.12305Z","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-08-20T06:09:11.123173Z","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-08-20T06:09:11.124096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-08-20T06:09:11.12933Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-08-20T06:09:11.131627Z","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-08-20T06:09:11.131742Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-08-20T06:09:11.131891Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-20T06:09:11.131936Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-20T06:09:11.131767Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-08-20T06:09:11.608932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-08-20T06:09:11.608988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-08-20T06:09:11.609031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-08-20T06:09:11.609044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-08-20T06:09:11.609055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-08-20T06:09:11.609066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-08-20T06:09:11.609075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-08-20T06:09:11.611766Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T06:09:11.612226Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-08-20T06:09:11.612399Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T06:09:11.612483Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T06:09:11.612575Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-20T06:09:11.612649Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-20T06:09:11.612743Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T06:09:11.612874Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T06:09:11.612929Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T06:09:11.614986Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-08-20T06:09:11.615805Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-20T06:09:27.426777Z","caller":"traceutil/trace.go:171","msg":"trace[2045687023] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"101.675501ms","start":"2026-08-20T06:09:27.32508Z","end":"2026-08-20T06:09:27.426756Z","steps":["trace[2045687023] 'process raft request' (duration: 101.523967ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:09:37.37177Z","caller":"traceutil/trace.go:171","msg":"trace[1969343343] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"218.271454ms","start":"2026-08-20T06:09:37.153468Z","end":"2026-08-20T06:09:37.371739Z","steps":["trace[1969343343] 'process raft request' (duration: 218.10985ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:09:48.656229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.992321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T06:09:48.656348Z","caller":"traceutil/trace.go:171","msg":"trace[560462583] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"279.30844ms","start":"2026-08-20T06:09:48.37702Z","end":"2026-08-20T06:09:48.656328Z","steps":["trace[560462583] 'process raft request' (duration: 175.357795ms)","trace[560462583] 'compare' (duration: 102.740795ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:09:48.657488Z","caller":"traceutil/trace.go:171","msg":"trace[1524567754] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:562; }","duration":"207.765585ms","start":"2026-08-20T06:09:48.449709Z","end":"2026-08-20T06:09:48.657475Z","steps":["trace[1524567754] 'read index received' (duration: 102.689633ms)","trace[1524567754] 'applied index is now lower than readState.Index' (duration: 105.075462ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:09:48.657718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.00945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:09:48.657782Z","caller":"traceutil/trace.go:171","msg":"trace[251878421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:545; }","duration":"208.111963ms","start":"2026-08-20T06:09:48.44966Z","end":"2026-08-20T06:09:48.657772Z","steps":["trace[251878421] 'agreement among raft nodes before linearized reading' (duration: 208.00768ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:09:48.657809Z","caller":"traceutil/trace.go:171","msg":"trace[604715530] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"262.835357ms","start":"2026-08-20T06:09:48.39494Z","end":"2026-08-20T06:09:48.657775Z","steps":["trace[604715530] 'process raft request' (duration: 262.245563ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:09:48.657886Z","caller":"traceutil/trace.go:171","msg":"trace[1067006572] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"158.493563ms","start":"2026-08-20T06:09:48.499382Z","end":"2026-08-20T06:09:48.657875Z","steps":["trace[1067006572] 'process raft request' (duration: 158.032642ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:09:48.657848Z","caller":"traceutil/trace.go:171","msg":"trace[900410349] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"242.810049ms","start":"2026-08-20T06:09:48.414996Z","end":"2026-08-20T06:09:48.657806Z","steps":["trace[900410349] 'process raft request' (duration: 242.320207ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:09:54.669971Z","caller":"traceutil/trace.go:171","msg":"trace[30917783] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"220.035484ms","start":"2026-08-20T06:09:54.449909Z","end":"2026-08-20T06:09:54.669945Z","steps":["trace[30917783] 'read index received' (duration: 219.04374ms)","trace[30917783] 'applied index is now lower than readState.Index' (duration: 990.914µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:09:54.670042Z","caller":"traceutil/trace.go:171","msg":"trace[1611783829] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"330.382214ms","start":"2026-08-20T06:09:54.339612Z","end":"2026-08-20T06:09:54.669995Z","steps":["trace[1611783829] 'process raft request' (duration: 329.79887ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:09:54.670113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.193388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:09:54.670153Z","caller":"traceutil/trace.go:171","msg":"trace[945681192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"220.295401ms","start":"2026-08-20T06:09:54.449847Z","end":"2026-08-20T06:09:54.670142Z","steps":["trace[945681192] 'agreement among raft nodes before linearized reading' (duration: 220.195468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:09:54.670217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:09:54.339586Z","time spent":"330.537548ms","remote":"127.0.0.1:38748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T06:09:55.032628Z","caller":"traceutil/trace.go:171","msg":"trace[519202234] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"190.459133ms","start":"2026-08-20T06:09:54.842094Z","end":"2026-08-20T06:09:55.032554Z","steps":["trace[519202234] 'read index received' (duration: 117.509774ms)","trace[519202234] 'applied index is now lower than readState.Index' (duration: 72.942168ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:09:55.032891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.770371ms","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-08-20T06:09:55.033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.760885ms","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-08-20T06:09:55.033016Z","caller":"traceutil/trace.go:171","msg":"trace[397774497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"190.934214ms","start":"2026-08-20T06:09:54.842055Z","end":"2026-08-20T06:09:55.032989Z","steps":["trace[397774497] 'agreement among raft nodes before linearized reading' (duration: 190.590296ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:09:55.033071Z","caller":"traceutil/trace.go:171","msg":"trace[242943475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"175.859088ms","start":"2026-08-20T06:09:54.85718Z","end":"2026-08-20T06:09:55.033039Z","steps":["trace[242943475] 'agreement among raft nodes before linearized reading' (duration: 175.646702ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:09:55.718708Z","caller":"traceutil/trace.go:171","msg":"trace[1261647826] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"268.499474ms","start":"2026-08-20T06:09:55.450183Z","end":"2026-08-20T06:09:55.718683Z","steps":["trace[1261647826] 'read index received' (duration: 267.669064ms)","trace[1261647826] 'applied index is now lower than readState.Index' (duration: 829.38µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:09:55.718766Z","caller":"traceutil/trace.go:171","msg":"trace[1080442542] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"577.362563ms","start":"2026-08-20T06:09:55.141372Z","end":"2026-08-20T06:09:55.718735Z","steps":["trace[1080442542] 'process raft request' (duration: 576.758339ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:09:55.718883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.674058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:09:55.718924Z","caller":"traceutil/trace.go:171","msg":"trace[2126164319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"268.768681ms","start":"2026-08-20T06:09:55.450144Z","end":"2026-08-20T06:09:55.718912Z","steps":["trace[2126164319] 'agreement among raft nodes before linearized reading' (duration: 268.676758ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:09:55.718928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:09:55.14135Z","time spent":"577.483157ms","remote":"127.0.0.1:38748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T06:09:55.719276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.886713ms","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-08-20T06:09:55.719362Z","caller":"traceutil/trace.go:171","msg":"trace[1072931140] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"149.992995ms","start":"2026-08-20T06:09:55.569349Z","end":"2026-08-20T06:09:55.719342Z","steps":["trace[1072931140] 'agreement among raft nodes before linearized reading' (duration: 149.747339ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:09:55.719366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.58499ms","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-08-20T06:09:55.719515Z","caller":"traceutil/trace.go:171","msg":"trace[1927401134] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"150.794675ms","start":"2026-08-20T06:09:55.568688Z","end":"2026-08-20T06:09:55.719483Z","steps":["trace[1927401134] 'agreement among raft nodes before linearized reading' (duration: 150.378335ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:10:11.106581Z","caller":"traceutil/trace.go:171","msg":"trace[1503594557] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"145.280251ms","start":"2026-08-20T06:10:10.961277Z","end":"2026-08-20T06:10:11.106557Z","steps":["trace[1503594557] 'process raft request' (duration: 145.080796ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:10:57.539188Z","caller":"traceutil/trace.go:171","msg":"trace[1241514354] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"114.374776ms","start":"2026-08-20T06:10:57.424782Z","end":"2026-08-20T06:10:57.539156Z","steps":["trace[1241514354] 'process raft request' (duration: 107.1437ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:10:58.137524Z","caller":"traceutil/trace.go:171","msg":"trace[1962332258] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"111.920956ms","start":"2026-08-20T06:10:58.025582Z","end":"2026-08-20T06:10:58.137503Z","steps":["trace[1962332258] 'process raft request' (duration: 110.44498ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:10:59.40093Z","caller":"traceutil/trace.go:171","msg":"trace[591085530] linearizableReadLoop","detail":"{readStateIndex:1360; appliedIndex:1359; }","duration":"125.699752ms","start":"2026-08-20T06:10:59.275201Z","end":"2026-08-20T06:10:59.4009Z","steps":["trace[591085530] 'read index received' (duration: 121.52237ms)","trace[591085530] 'applied index is now lower than readState.Index' (duration: 4.176062ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:10:59.40122Z","caller":"traceutil/trace.go:171","msg":"trace[1519094195] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"132.178209ms","start":"2026-08-20T06:10:59.269017Z","end":"2026-08-20T06:10:59.401196Z","steps":["trace[1519094195] 'process raft request' (duration: 127.805982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:10:59.401381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.111561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:10:59.40154Z","caller":"traceutil/trace.go:171","msg":"trace[1941255161] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1319; }","duration":"126.376268ms","start":"2026-08-20T06:10:59.275146Z","end":"2026-08-20T06:10:59.401522Z","steps":["trace[1941255161] 'agreement among raft nodes before linearized reading' (duration: 125.904236ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:11:06.244013Z","caller":"traceutil/trace.go:171","msg":"trace[1359119246] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"128.584842ms","start":"2026-08-20T06:11:06.115404Z","end":"2026-08-20T06:11:06.243989Z","steps":["trace[1359119246] 'process raft request' (duration: 118.810633ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:11:32.881338Z","caller":"traceutil/trace.go:171","msg":"trace[677911900] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"129.804391ms","start":"2026-08-20T06:11:32.751504Z","end":"2026-08-20T06:11:32.881309Z","steps":["trace[677911900] 'process raft request' (duration: 72.493245ms)","trace[677911900] 'compare' (duration: 57.200593ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:11:33.499673Z","caller":"traceutil/trace.go:171","msg":"trace[1551024547] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"251.73167ms","start":"2026-08-20T06:11:33.247914Z","end":"2026-08-20T06:11:33.499646Z","steps":["trace[1551024547] 'process raft request' (duration: 251.591636ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:11:33.951951Z","caller":"traceutil/trace.go:171","msg":"trace[732732830] linearizableReadLoop","detail":"{readStateIndex:1949; appliedIndex:1948; }","duration":"169.485507ms","start":"2026-08-20T06:11:33.782443Z","end":"2026-08-20T06:11:33.951928Z","steps":["trace[732732830] 'read index received' (duration: 169.290662ms)","trace[732732830] 'applied index is now lower than readState.Index' (duration: 193.825µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:11:33.952062Z","caller":"traceutil/trace.go:171","msg":"trace[1187931336] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"204.538341ms","start":"2026-08-20T06:11:33.747512Z","end":"2026-08-20T06:11:33.95205Z","steps":["trace[1187931336] 'process raft request' (duration: 204.281285ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:11:33.952382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.922557ms","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-08-20T06:11:33.95255Z","caller":"traceutil/trace.go:171","msg":"trace[651986757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1880; }","duration":"170.124342ms","start":"2026-08-20T06:11:33.782361Z","end":"2026-08-20T06:11:33.952485Z","steps":["trace[651986757] 'agreement among raft nodes before linearized reading' (duration: 169.889217ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:12:07.460369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.992617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-20T06:12:07.460483Z","caller":"traceutil/trace.go:171","msg":"trace[81424925] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2123; }","duration":"181.14749ms","start":"2026-08-20T06:12:07.279294Z","end":"2026-08-20T06:12:07.460441Z","steps":["trace[81424925] 'range keys from in-memory index tree' (duration: 180.801562ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:12:08.242496Z","caller":"traceutil/trace.go:171","msg":"trace[1350988299] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2199; }","duration":"132.847443ms","start":"2026-08-20T06:12:08.109623Z","end":"2026-08-20T06:12:08.242471Z","steps":["trace[1350988299] 'read index received' (duration: 72.163916ms)","trace[1350988299] 'applied index is now lower than readState.Index' (duration: 60.682517ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:12:08.242745Z","caller":"traceutil/trace.go:171","msg":"trace[359213507] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"133.189651ms","start":"2026-08-20T06:12:08.109541Z","end":"2026-08-20T06:12:08.24273Z","steps":["trace[359213507] 'process raft request' (duration: 132.849373ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:12:08.242897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.500054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:12:08.243423Z","caller":"traceutil/trace.go:171","msg":"trace[378636851] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:2125; }","duration":"128.030236ms","start":"2026-08-20T06:12:08.11536Z","end":"2026-08-20T06:12:08.24339Z","steps":["trace[378636851] 'agreement among raft nodes before linearized reading' (duration: 127.464973ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:12:08.243122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.411967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-20T06:12:08.243533Z","caller":"traceutil/trace.go:171","msg":"trace[1221290449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2125; }","duration":"133.899188ms","start":"2026-08-20T06:12:08.109603Z","end":"2026-08-20T06:12:08.243502Z","steps":["trace[1221290449] 'agreement among raft nodes before linearized reading' (duration: 133.346595ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:12:08.679965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.380501ms","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-08-20T06:12:08.680024Z","caller":"traceutil/trace.go:171","msg":"trace[486400970] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2126; }","duration":"281.487494ms","start":"2026-08-20T06:12:08.398522Z","end":"2026-08-20T06:12:08.680009Z","steps":["trace[486400970] 'range keys from in-memory index tree' (duration: 281.200446ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:12:08.680187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.376709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:12:08.680256Z","caller":"traceutil/trace.go:171","msg":"trace[2057856328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2126; }","duration":"230.502972ms","start":"2026-08-20T06:12:08.449737Z","end":"2026-08-20T06:12:08.68024Z","steps":["trace[2057856328] 'range keys from in-memory index tree' (duration: 230.256056ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:12:08.680187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.910114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-20T06:12:08.680432Z","caller":"traceutil/trace.go:171","msg":"trace[1647721215] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2126; }","duration":"211.211481ms","start":"2026-08-20T06:12:08.469206Z","end":"2026-08-20T06:12:08.680417Z","steps":["trace[1647721215] 'range keys from in-memory index tree' (duration: 210.72495ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:12:08.686559Z","caller":"traceutil/trace.go:171","msg":"trace[640270638] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"205.688237ms","start":"2026-08-20T06:12:08.480849Z","end":"2026-08-20T06:12:08.686537Z","steps":["trace[640270638] 'process raft request' (duration: 205.566684ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:12:08.909734Z","caller":"traceutil/trace.go:171","msg":"trace[1029233629] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"360.061736ms","start":"2026-08-20T06:12:08.549629Z","end":"2026-08-20T06:12:08.909691Z","steps":["trace[1029233629] 'process raft request' (duration: 326.453838ms)","trace[1029233629] 'compare' (duration: 33.397053ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:12:08.909802Z","caller":"traceutil/trace.go:171","msg":"trace[322449552] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"315.07566ms","start":"2026-08-20T06:12:08.594709Z","end":"2026-08-20T06:12:08.909784Z","steps":["trace[322449552] 'process raft request' (duration: 314.902696ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:12:08.909881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:12:08.549594Z","time spent":"360.21723ms","remote":"127.0.0.1:38716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":819,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:12:08.909899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:12:08.594693Z","time spent":"315.151303ms","remote":"127.0.0.1:38948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T06:12:08.910498Z","caller":"traceutil/trace.go:171","msg":"trace[675377367] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"114.6431ms","start":"2026-08-20T06:12:08.795841Z","end":"2026-08-20T06:12:08.910484Z","steps":["trace[675377367] 'process raft request' (duration: 114.60748ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:12:08.910671Z","caller":"traceutil/trace.go:171","msg":"trace[700173653] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"225.593402ms","start":"2026-08-20T06:12:08.685053Z","end":"2026-08-20T06:12:08.910646Z","steps":["trace[700173653] 'process raft request' (duration: 225.329266ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:12:08.910713Z","caller":"traceutil/trace.go:171","msg":"trace[659132780] linearizableReadLoop","detail":"{readStateIndex:2204; appliedIndex:2202; }","duration":"359.516822ms","start":"2026-08-20T06:12:08.551168Z","end":"2026-08-20T06:12:08.910685Z","steps":["trace[659132780] 'read index received' (duration: 135.259433ms)","trace[659132780] 'applied index is now lower than readState.Index' (duration: 224.254279ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:12:08.910864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.654327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T06:12:08.911991Z","caller":"traceutil/trace.go:171","msg":"trace[2141281622] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2131; }","duration":"360.841745ms","start":"2026-08-20T06:12:08.551132Z","end":"2026-08-20T06:12:08.911974Z","steps":["trace[2141281622] 'agreement among raft nodes before linearized reading' (duration: 359.633315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:12:08.912049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:12:08.55112Z","time spent":"360.906597ms","remote":"127.0.0.1:52912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":2,"response size":29,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-08-20T06:12:08.912157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.923604ms","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-08-20T06:12:08.912207Z","caller":"traceutil/trace.go:171","msg":"trace[743915449] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2131; }","duration":"282.015576ms","start":"2026-08-20T06:12:08.63018Z","end":"2026-08-20T06:12:08.912195Z","steps":["trace[743915449] 'agreement among raft nodes before linearized reading' (duration: 281.863272ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:12:08.912325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.700127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:12:08.912397Z","caller":"traceutil/trace.go:171","msg":"trace[124055244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2131; }","duration":"230.904662ms","start":"2026-08-20T06:12:08.681475Z","end":"2026-08-20T06:12:08.912379Z","steps":["trace[124055244] 'agreement among raft nodes before linearized reading' (duration: 230.672216ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:13:44.940038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.542368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T06:13:44.940164Z","caller":"traceutil/trace.go:171","msg":"trace[508081629] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:2752; }","duration":"120.735553ms","start":"2026-08-20T06:13:44.819397Z","end":"2026-08-20T06:13:44.940133Z","steps":["trace[508081629] 'range keys from in-memory index tree' (duration: 120.28185ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:13:45.185151Z","caller":"traceutil/trace.go:171","msg":"trace[1754491697] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"153.480916ms","start":"2026-08-20T06:13:45.031635Z","end":"2026-08-20T06:13:45.185116Z","steps":["trace[1754491697] 'process raft request' (duration: 115.168011ms)","trace[1754491697] 'compare' (duration: 37.893122ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:17:25.025886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.119388ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-20T06:17:25.026262Z","caller":"traceutil/trace.go:171","msg":"trace[1013498101] linearizableReadLoop","detail":"{readStateIndex:4589; appliedIndex:4586; }","duration":"267.08777ms","start":"2026-08-20T06:17:24.759149Z","end":"2026-08-20T06:17:25.026237Z","steps":["trace[1013498101] 'read index received' (duration: 34.523651ms)","trace[1013498101] 'applied index is now lower than readState.Index' (duration: 232.562879ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:17:25.026408Z","caller":"traceutil/trace.go:171","msg":"trace[1670458351] transaction","detail":"{read_only:false; response_revision:4424; number_of_response:1; }","duration":"261.7218ms","start":"2026-08-20T06:17:24.764656Z","end":"2026-08-20T06:17:25.026377Z","steps":["trace[1670458351] 'process raft request' (duration: 261.531005ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:25.02642Z","caller":"traceutil/trace.go:171","msg":"trace[751476036] transaction","detail":"{read_only:false; response_revision:4423; number_of_response:1; }","duration":"269.835932ms","start":"2026-08-20T06:17:24.756551Z","end":"2026-08-20T06:17:25.026387Z","steps":["trace[751476036] 'process raft request' (duration: 269.590425ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:25.02644Z","caller":"traceutil/trace.go:171","msg":"trace[2069238739] transaction","detail":"{read_only:false; response_revision:4421; number_of_response:1; }","duration":"283.748035ms","start":"2026-08-20T06:17:24.742652Z","end":"2026-08-20T06:17:25.0264Z","steps":["trace[2069238739] 'process raft request' (duration: 51.003721ms)","trace[2069238739] 'compare' (duration: 231.927513ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:17:25.026402Z","caller":"traceutil/trace.go:171","msg":"trace[1515742698] transaction","detail":"{read_only:false; response_revision:4422; number_of_response:1; }","duration":"282.920964ms","start":"2026-08-20T06:17:24.743455Z","end":"2026-08-20T06:17:25.026376Z","steps":["trace[1515742698] 'process raft request' (duration: 282.560594ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:17:25.026582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.860035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-20T06:17:25.026593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.254573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/grafana-tls\" ","response":"range_response_count:1 size:2834"} {"level":"info","ts":"2026-08-20T06:17:25.026644Z","caller":"traceutil/trace.go:171","msg":"trace[1622515528] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:4424; }","duration":"194.969268ms","start":"2026-08-20T06:17:24.831659Z","end":"2026-08-20T06:17:25.026628Z","steps":["trace[1622515528] 'agreement among raft nodes before linearized reading' (duration: 194.756593ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:17:25.026568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.426939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-patch-v2cfl\" ","response":"range_response_count:1 size:3378"} {"level":"warn","ts":"2026-08-20T06:17:25.026647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.522973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-tls\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:17:25.026696Z","caller":"traceutil/trace.go:171","msg":"trace[2013966526] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-tls; range_end:; response_count:0; response_revision:4424; }","duration":"205.624776ms","start":"2026-08-20T06:17:24.82106Z","end":"2026-08-20T06:17:25.026685Z","steps":["trace[2013966526] 'agreement among raft nodes before linearized reading' (duration: 205.532623ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:25.0267Z","caller":"traceutil/trace.go:171","msg":"trace[931379829] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-patch-v2cfl; range_end:; response_count:1; response_revision:4424; }","duration":"267.580783ms","start":"2026-08-20T06:17:24.759102Z","end":"2026-08-20T06:17:25.026682Z","steps":["trace[931379829] 'agreement among raft nodes before linearized reading' (duration: 267.299115ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:25.02665Z","caller":"traceutil/trace.go:171","msg":"trace[1369527928] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/grafana-tls; range_end:; response_count:1; response_revision:4424; }","duration":"252.320224ms","start":"2026-08-20T06:17:24.774312Z","end":"2026-08-20T06:17:25.026632Z","steps":["trace[1369527928] 'agreement among raft nodes before linearized reading' (duration: 252.101488ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:28.137142Z","caller":"traceutil/trace.go:171","msg":"trace[499707258] transaction","detail":"{read_only:false; response_revision:4503; number_of_response:1; }","duration":"134.603949ms","start":"2026-08-20T06:17:28.002516Z","end":"2026-08-20T06:17:28.13712Z","steps":["trace[499707258] 'process raft request' (duration: 130.04697ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:28.139255Z","caller":"traceutil/trace.go:171","msg":"trace[862039867] transaction","detail":"{read_only:false; response_revision:4504; number_of_response:1; }","duration":"113.891479ms","start":"2026-08-20T06:17:28.025341Z","end":"2026-08-20T06:17:28.139232Z","steps":["trace[862039867] 'process raft request' (duration: 113.365325ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:17:33.017504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.065078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-08-20T06:17:33.017582Z","caller":"traceutil/trace.go:171","msg":"trace[2042482660] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4622; }","duration":"170.170432ms","start":"2026-08-20T06:17:32.847394Z","end":"2026-08-20T06:17:33.017565Z","steps":["trace[2042482660] 'range keys from in-memory index tree' (duration: 169.935705ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:33.017734Z","caller":"traceutil/trace.go:171","msg":"trace[1713227078] transaction","detail":"{read_only:false; response_revision:4623; number_of_response:1; }","duration":"166.754283ms","start":"2026-08-20T06:17:32.850965Z","end":"2026-08-20T06:17:33.017719Z","steps":["trace[1713227078] 'process raft request' (duration: 166.672331ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:17:33.35884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.268838ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T06:17:33.358914Z","caller":"traceutil/trace.go:171","msg":"trace[460057749] linearizableReadLoop","detail":"{readStateIndex:4811; appliedIndex:4810; }","duration":"139.891272ms","start":"2026-08-20T06:17:33.219011Z","end":"2026-08-20T06:17:33.358902Z","steps":["trace[460057749] 'read index received' (duration: 26.434718ms)","trace[460057749] 'applied index is now lower than readState.Index' (duration: 113.455794ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:17:33.359011Z","caller":"traceutil/trace.go:171","msg":"trace[1402096543] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"141.140884ms","start":"2026-08-20T06:17:33.217859Z","end":"2026-08-20T06:17:33.359Z","steps":["trace[1402096543] 'process raft request' (duration: 27.6496ms)","trace[1402096543] 'compare' (duration: 113.133675ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:17:33.359519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.503287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:57194"} {"level":"info","ts":"2026-08-20T06:17:33.359566Z","caller":"traceutil/trace.go:171","msg":"trace[108847058] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4638; }","duration":"140.57475ms","start":"2026-08-20T06:17:33.218984Z","end":"2026-08-20T06:17:33.359559Z","steps":["trace[108847058] 'agreement among raft nodes before linearized reading' (duration: 139.948783ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:33.381529Z","caller":"traceutil/trace.go:171","msg":"trace[338634831] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"157.305065ms","start":"2026-08-20T06:17:33.224205Z","end":"2026-08-20T06:17:33.38151Z","steps":["trace[338634831] 'process raft request' (duration: 157.203713ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:17:38.766523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.096581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-20T06:17:38.766646Z","caller":"traceutil/trace.go:171","msg":"trace[410504771] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4699; }","duration":"103.335377ms","start":"2026-08-20T06:17:38.663286Z","end":"2026-08-20T06:17:38.766622Z","steps":["trace[410504771] 'range keys from in-memory index tree' (duration: 102.854474ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:17:38.766581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.406041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-20T06:17:38.766725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.243711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:17:38.766732Z","caller":"traceutil/trace.go:171","msg":"trace[563480955] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4699; }","duration":"100.567905ms","start":"2026-08-20T06:17:38.666136Z","end":"2026-08-20T06:17:38.766704Z","steps":["trace[563480955] 'range keys from in-memory index tree' (duration: 100.275268ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:38.766852Z","caller":"traceutil/trace.go:171","msg":"trace[1286571709] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4699; }","duration":"109.453647ms","start":"2026-08-20T06:17:38.657312Z","end":"2026-08-20T06:17:38.766765Z","steps":["trace[1286571709] 'range keys from in-memory index tree' (duration: 109.155339ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:38.958427Z","caller":"traceutil/trace.go:171","msg":"trace[1585924538] linearizableReadLoop","detail":"{readStateIndex:4875; appliedIndex:4874; }","duration":"184.686383ms","start":"2026-08-20T06:17:38.773709Z","end":"2026-08-20T06:17:38.958396Z","steps":["trace[1585924538] 'read index received' (duration: 184.673502ms)","trace[1585924538] 'applied index is now lower than readState.Index' (duration: 10.361µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:17:38.958487Z","caller":"traceutil/trace.go:171","msg":"trace[1212887340] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"187.303511ms","start":"2026-08-20T06:17:38.771103Z","end":"2026-08-20T06:17:38.958406Z","steps":["trace[1212887340] 'process raft request' (duration: 187.132637ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:17:38.958569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.834237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:17:38.95862Z","caller":"traceutil/trace.go:171","msg":"trace[1285375999] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:4700; }","duration":"184.911439ms","start":"2026-08-20T06:17:38.773686Z","end":"2026-08-20T06:17:38.958597Z","steps":["trace[1285375999] 'agreement among raft nodes before linearized reading' (duration: 184.824167ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:39.017107Z","caller":"traceutil/trace.go:171","msg":"trace[962595732] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"242.917037ms","start":"2026-08-20T06:17:38.774176Z","end":"2026-08-20T06:17:39.017093Z","steps":["trace[962595732] 'process raft request' (duration: 240.393081ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:17:39.52598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.144048ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-20T06:17:39.526337Z","caller":"traceutil/trace.go:171","msg":"trace[1631583104] linearizableReadLoop","detail":"{readStateIndex:4889; appliedIndex:4888; }","duration":"165.562335ms","start":"2026-08-20T06:17:39.360757Z","end":"2026-08-20T06:17:39.526319Z","steps":["trace[1631583104] 'read index received' (duration: 5.980576ms)","trace[1631583104] 'applied index is now lower than readState.Index' (duration: 159.579639ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:17:39.526358Z","caller":"traceutil/trace.go:171","msg":"trace[1852702887] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"166.313974ms","start":"2026-08-20T06:17:39.359993Z","end":"2026-08-20T06:17:39.526307Z","steps":["trace[1852702887] 'compare' (duration: 158.981494ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:39.526479Z","caller":"traceutil/trace.go:171","msg":"trace[788238690] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"165.121243ms","start":"2026-08-20T06:17:39.361254Z","end":"2026-08-20T06:17:39.526375Z","steps":["trace[788238690] 'process raft request' (duration: 165.060031ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:39.526491Z","caller":"traceutil/trace.go:171","msg":"trace[761503926] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"165.403061ms","start":"2026-08-20T06:17:39.361067Z","end":"2026-08-20T06:17:39.52647Z","steps":["trace[761503926] 'process raft request' (duration: 165.164934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:17:39.526539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.76433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:125189"} {"level":"info","ts":"2026-08-20T06:17:39.526874Z","caller":"traceutil/trace.go:171","msg":"trace[205492234] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:4716; }","duration":"166.115588ms","start":"2026-08-20T06:17:39.360734Z","end":"2026-08-20T06:17:39.52685Z","steps":["trace[205492234] 'agreement among raft nodes before linearized reading' (duration: 165.667427ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:39.566747Z","caller":"traceutil/trace.go:171","msg":"trace[99113874] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"189.870096ms","start":"2026-08-20T06:17:39.376863Z","end":"2026-08-20T06:17:39.566733Z","steps":["trace[99113874] 'process raft request' (duration: 189.763704ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:17:39.566977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.065441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-08-20T06:17:39.567058Z","caller":"traceutil/trace.go:171","msg":"trace[242734185] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4717; }","duration":"205.177164ms","start":"2026-08-20T06:17:39.361861Z","end":"2026-08-20T06:17:39.567038Z","steps":["trace[242734185] 'agreement among raft nodes before linearized reading' (duration: 204.906777ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:39.72523Z","caller":"traceutil/trace.go:171","msg":"trace[96126874] linearizableReadLoop","detail":"{readStateIndex:4894; appliedIndex:4893; }","duration":"123.991184ms","start":"2026-08-20T06:17:39.601215Z","end":"2026-08-20T06:17:39.725206Z","steps":["trace[96126874] 'read index received' (duration: 27.743492ms)","trace[96126874] 'applied index is now lower than readState.Index' (duration: 96.246642ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:17:39.725492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.260961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-08-20T06:17:39.725553Z","caller":"traceutil/trace.go:171","msg":"trace[531215390] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4719; }","duration":"124.368194ms","start":"2026-08-20T06:17:39.601167Z","end":"2026-08-20T06:17:39.725535Z","steps":["trace[531215390] 'agreement among raft nodes before linearized reading' (duration: 124.131557ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:17:39.725689Z","caller":"traceutil/trace.go:171","msg":"trace[871530730] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"130.521983ms","start":"2026-08-20T06:17:39.595141Z","end":"2026-08-20T06:17:39.725662Z","steps":["trace[871530730] 'process raft request' (duration: 33.838989ms)","trace[871530730] 'compare' (duration: 95.918974ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:17:42.274627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.777289ms","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-08-20T06:17:42.274749Z","caller":"traceutil/trace.go:171","msg":"trace[561263799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4790; }","duration":"192.987393ms","start":"2026-08-20T06:17:42.081736Z","end":"2026-08-20T06:17:42.274724Z","steps":["trace[561263799] 'range keys from in-memory index tree' (duration: 192.548233ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:18:29.605519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.464082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:18:29.605615Z","caller":"traceutil/trace.go:171","msg":"trace[435660417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5265; }","duration":"155.613446ms","start":"2026-08-20T06:18:29.449986Z","end":"2026-08-20T06:18:29.605599Z","steps":["trace[435660417] 'range keys from in-memory index tree' (duration: 155.39029ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:18:29.606466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.661896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-20T06:18:29.606564Z","caller":"traceutil/trace.go:171","msg":"trace[2120065268] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5265; }","duration":"174.79366ms","start":"2026-08-20T06:18:29.431746Z","end":"2026-08-20T06:18:29.60654Z","steps":["trace[2120065268] 'range keys from in-memory index tree' (duration: 173.749533ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:19:11.816506Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2897} {"level":"info","ts":"2026-08-20T06:19:11.913383Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2897,"took":"95.471893ms","hash":545434918,"current-db-size-bytes":53874688,"current-db-size":"54 MB","current-db-size-in-use-bytes":29282304,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-20T06:19:11.913453Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":545434918,"revision":2897,"compact-revision":-1} {"level":"info","ts":"2026-08-20T06:21:45.148578Z","caller":"traceutil/trace.go:171","msg":"trace[1056112241] transaction","detail":"{read_only:false; response_revision:6643; number_of_response:1; }","duration":"165.551857ms","start":"2026-08-20T06:21:44.982981Z","end":"2026-08-20T06:21:45.148533Z","steps":["trace[1056112241] 'process raft request' (duration: 108.906222ms)","trace[1056112241] 'compare' (duration: 56.487349ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:24:11.822972Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5589} {"level":"info","ts":"2026-08-20T06:24:11.901623Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5589,"took":"77.486701ms","hash":2794584902,"current-db-size-bytes":53874688,"current-db-size":"54 MB","current-db-size-in-use-bytes":18198528,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-20T06:24:11.90168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2794584902,"revision":5589,"compact-revision":2897}