{"level":"warn","ts":"2026-05-30T09:40:38.309932Z","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-30T09:40:38.310022Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-30T09:40:38.310086Z","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-30T09:40:38.310098Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-05-30T09:40:38.310116Z","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-30T09:40:38.310852Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-05-30T09:40:38.310919Z","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.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-30T09:40:38.316132Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.042821ms"} {"level":"info","ts":"2026-05-30T09:40:38.323366Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-05-30T09:40:38.323446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T09:40:38.32347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-05-30T09:40:38.323482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T09:40:38.323493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-05-30T09:40:38.323527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-05-30T09:40:38.333467Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T09:40:38.334707Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T09:40:38.335507Z","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-30T09:40:38.337704Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T09:40:38.338465Z","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-30T09:40:38.338577Z","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-30T09:40:38.33802Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T09:40:38.338858Z","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-30T09:40:38.339491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-05-30T09:40:38.341041Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-05-30T09:40:38.342789Z","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-30T09:40:38.342875Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-05-30T09:40:38.342918Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-05-30T09:40:38.342986Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T09:40:38.343015Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T09:40:39.024699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T09:40:39.024775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T09:40:39.024801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-05-30T09:40:39.024825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-05-30T09:40:39.024846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-05-30T09:40:39.024868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-05-30T09:40:39.024887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-05-30T09:40:39.025807Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T09:40:39.026681Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T09:40:39.026704Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T09:40:39.026677Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T09:40:39.027056Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T09:40:39.030188Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T09:40:39.027428Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T09:40:39.030274Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T09:40:39.030305Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T09:40:39.029932Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-05-30T09:40:39.030102Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-30T09:40:40.444478Z","caller":"traceutil/trace.go:171","msg":"trace[1030857513] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"162.973661ms","start":"2026-05-30T09:40:40.281483Z","end":"2026-05-30T09:40:40.444457Z","steps":["trace[1030857513] 'read index received' (duration: 162.698777ms)","trace[1030857513] 'applied index is now lower than readState.Index' (duration: 273.944µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:40:40.444539Z","caller":"traceutil/trace.go:171","msg":"trace[1114471308] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"165.01917ms","start":"2026-05-30T09:40:40.279481Z","end":"2026-05-30T09:40:40.4445Z","steps":["trace[1114471308] 'process raft request' (duration: 164.766386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.444667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.161144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:40:40.444727Z","caller":"traceutil/trace.go:171","msg":"trace[1854456725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2; }","duration":"163.248775ms","start":"2026-05-30T09:40:40.281468Z","end":"2026-05-30T09:40:40.444716Z","steps":["trace[1854456725] 'agreement among raft nodes before linearized reading' (duration: 163.105363ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:40:40.738832Z","caller":"traceutil/trace.go:171","msg":"trace[2146891762] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"386.511357ms","start":"2026-05-30T09:40:40.352289Z","end":"2026-05-30T09:40:40.738801Z","steps":["trace[2146891762] 'process raft request' (duration: 386.398816ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:40:40.738857Z","caller":"traceutil/trace.go:171","msg":"trace[1003129174] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"386.588609ms","start":"2026-05-30T09:40:40.352202Z","end":"2026-05-30T09:40:40.73879Z","steps":["trace[1003129174] 'process raft request' (duration: 386.307755ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:40:40.739326Z","caller":"traceutil/trace.go:171","msg":"trace[1224104008] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"386.934464ms","start":"2026-05-30T09:40:40.352344Z","end":"2026-05-30T09:40:40.739278Z","steps":["trace[1224104008] 'process raft request' (duration: 386.375506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.739384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.352282Z","time spent":"386.63631ms","remote":"127.0.0.1:49372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:40:40.739459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.352337Z","time spent":"387.065905ms","remote":"127.0.0.1:49372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:40:40.739551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.352182Z","time spent":"386.827202ms","remote":"127.0.0.1:49372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:40:40.739624Z","caller":"traceutil/trace.go:171","msg":"trace[456495756] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"387.088286ms","start":"2026-05-30T09:40:40.352519Z","end":"2026-05-30T09:40:40.739607Z","steps":["trace[456495756] 'process raft request' (duration: 386.984874ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:40:40.739629Z","caller":"traceutil/trace.go:171","msg":"trace[614274383] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"295.053145ms","start":"2026-05-30T09:40:40.444551Z","end":"2026-05-30T09:40:40.739604Z","steps":["trace[614274383] 'read index received' (duration: 294.00252ms)","trace[614274383] 'applied index is now lower than readState.Index' (duration: 1.049135ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:40:40.739668Z","caller":"traceutil/trace.go:171","msg":"trace[725890002] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"387.31714ms","start":"2026-05-30T09:40:40.352344Z","end":"2026-05-30T09:40:40.739661Z","steps":["trace[725890002] 'process raft request' (duration: 386.406686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.739704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.352504Z","time spent":"387.166008ms","remote":"127.0.0.1:49306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:40:40.739718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.352306Z","time spent":"387.39075ms","remote":"127.0.0.1:49372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:40:40.739764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.232819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:40:40.739642Z","caller":"traceutil/trace.go:171","msg":"trace[1914128570] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"387.221168ms","start":"2026-05-30T09:40:40.352407Z","end":"2026-05-30T09:40:40.739628Z","steps":["trace[1914128570] 'process raft request' (duration: 387.001864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.739858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.352384Z","time spent":"387.437131ms","remote":"127.0.0.1:49372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:40:40.739801Z","caller":"traceutil/trace.go:171","msg":"trace[1967712135] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:10; }","duration":"458.307259ms","start":"2026-05-30T09:40:40.281485Z","end":"2026-05-30T09:40:40.739792Z","steps":["trace[1967712135] 'agreement among raft nodes before linearized reading' (duration: 458.207238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.739995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.281474Z","time spent":"458.503132ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-05-30T09:40:40.740067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.975318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:40:40.740116Z","caller":"traceutil/trace.go:171","msg":"trace[1171700797] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"388.245232ms","start":"2026-05-30T09:40:40.351856Z","end":"2026-05-30T09:40:40.740102Z","steps":["trace[1171700797] 'agreement among raft nodes before linearized reading' (duration: 388.173941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.740131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.514011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:40:40.740166Z","caller":"traceutil/trace.go:171","msg":"trace[1858258407] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"405.595851ms","start":"2026-05-30T09:40:40.33456Z","end":"2026-05-30T09:40:40.740156Z","steps":["trace[1858258407] 'agreement among raft nodes before linearized reading' (duration: 405.542761ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.740199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.334528Z","time spent":"405.665783ms","remote":"127.0.0.1:49012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-30T09:40:40.740204Z","caller":"traceutil/trace.go:171","msg":"trace[922914533] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"381.830554ms","start":"2026-05-30T09:40:40.358364Z","end":"2026-05-30T09:40:40.740194Z","steps":["trace[922914533] 'process raft request' (duration: 381.173454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.740272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.35835Z","time spent":"381.877214ms","remote":"127.0.0.1:49150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:40:40.740167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.351845Z","time spent":"388.314792ms","remote":"127.0.0.1:49012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-30T09:40:40.740344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.515541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:40:40.740404Z","caller":"traceutil/trace.go:171","msg":"trace[394678918] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"405.603111ms","start":"2026-05-30T09:40:40.334785Z","end":"2026-05-30T09:40:40.740388Z","steps":["trace[394678918] 'agreement among raft nodes before linearized reading' (duration: 405.52161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.740457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.334764Z","time spent":"405.683163ms","remote":"127.0.0.1:49012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-30T09:40:40.740473Z","caller":"traceutil/trace.go:171","msg":"trace[343137930] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"378.087442ms","start":"2026-05-30T09:40:40.362376Z","end":"2026-05-30T09:40:40.740463Z","steps":["trace[343137930] 'process raft request' (duration: 377.186208ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.74052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.362357Z","time spent":"378.141992ms","remote":"127.0.0.1:49088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:40:40.740572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.091061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:40:40.740634Z","caller":"traceutil/trace.go:171","msg":"trace[921093770] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:0; response_revision:10; }","duration":"391.221033ms","start":"2026-05-30T09:40:40.349401Z","end":"2026-05-30T09:40:40.740622Z","steps":["trace[921093770] 'agreement among raft nodes before linearized reading' (duration: 391.146332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.74068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.46352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-30T09:40:40.740685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.349385Z","time spent":"391.283234ms","remote":"127.0.0.1:48936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"info","ts":"2026-05-30T09:40:40.74072Z","caller":"traceutil/trace.go:171","msg":"trace[7019396] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"387.534702ms","start":"2026-05-30T09:40:40.353176Z","end":"2026-05-30T09:40:40.74071Z","steps":["trace[7019396] 'agreement among raft nodes before linearized reading' (duration: 387.468951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.740742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.353167Z","time spent":"387.570032ms","remote":"127.0.0.1:48994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-05-30T09:40:40.740767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.643509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:40:40.740805Z","caller":"traceutil/trace.go:171","msg":"trace[1975606617] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"315.71161ms","start":"2026-05-30T09:40:40.425085Z","end":"2026-05-30T09:40:40.740796Z","steps":["trace[1975606617] 'agreement among raft nodes before linearized reading' (duration: 315.660739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.740803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.966479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:40:40.740904Z","caller":"traceutil/trace.go:171","msg":"trace[2075099147] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"459.229212ms","start":"2026-05-30T09:40:40.281658Z","end":"2026-05-30T09:40:40.740887Z","steps":["trace[2075099147] 'agreement among raft nodes before linearized reading' (duration: 458.964849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.740981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.281634Z","time spent":"459.336463ms","remote":"127.0.0.1:49268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-30T09:40:40.740835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.425039Z","time spent":"315.79082ms","remote":"127.0.0.1:49012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-30T09:40:40.740862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.036804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-30T09:40:40.741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.004919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-05-30T09:40:40.741069Z","caller":"traceutil/trace.go:171","msg":"trace[582604692] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"337.269907ms","start":"2026-05-30T09:40:40.40379Z","end":"2026-05-30T09:40:40.74106Z","steps":["trace[582604692] 'agreement among raft nodes before linearized reading' (duration: 337.056284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.741104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.403774Z","time spent":"337.322217ms","remote":"127.0.0.1:49012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-30T09:40:40.7411Z","caller":"traceutil/trace.go:171","msg":"trace[1004654488] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"459.132031ms","start":"2026-05-30T09:40:40.281944Z","end":"2026-05-30T09:40:40.741076Z","steps":["trace[1004654488] 'agreement among raft nodes before linearized reading' (duration: 458.905868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:40:40.741169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:40:40.281936Z","time spent":"459.220452ms","remote":"127.0.0.1:49088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-30T09:40:41.672346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.24297ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-30T09:40:41.672514Z","caller":"traceutil/trace.go:171","msg":"trace[271652022] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"154.276705ms","start":"2026-05-30T09:40:41.518215Z","end":"2026-05-30T09:40:41.672492Z","steps":["trace[271652022] 'process raft request' (duration: 33.549207ms)","trace[271652022] 'compare' (duration: 119.963007ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:41:15.860907Z","caller":"traceutil/trace.go:171","msg":"trace[1117379144] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"115.249661ms","start":"2026-05-30T09:41:15.745624Z","end":"2026-05-30T09:41:15.860873Z","steps":["trace[1117379144] 'process raft request' (duration: 114.803206ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:16.03292Z","caller":"traceutil/trace.go:171","msg":"trace[2085344194] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"146.253315ms","start":"2026-05-30T09:41:15.886638Z","end":"2026-05-30T09:41:16.032891Z","steps":["trace[2085344194] 'process raft request' (duration: 146.093983ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:16.038676Z","caller":"traceutil/trace.go:171","msg":"trace[539803946] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"151.991562ms","start":"2026-05-30T09:41:15.886661Z","end":"2026-05-30T09:41:16.038652Z","steps":["trace[539803946] 'process raft request' (duration: 151.885241ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:16.156607Z","caller":"traceutil/trace.go:171","msg":"trace[546344787] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"104.336387ms","start":"2026-05-30T09:41:16.052242Z","end":"2026-05-30T09:41:16.156578Z","steps":["trace[546344787] 'process raft request' (duration: 101.61141ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:16.606343Z","caller":"traceutil/trace.go:171","msg":"trace[1948586035] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"210.22718ms","start":"2026-05-30T09:41:16.396083Z","end":"2026-05-30T09:41:16.606311Z","steps":["trace[1948586035] 'process raft request' (duration: 144.595043ms)","trace[1948586035] 'compare' (duration: 65.521496ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:41:16.607979Z","caller":"traceutil/trace.go:171","msg":"trace[1497681261] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:539; }","duration":"193.199181ms","start":"2026-05-30T09:41:16.414763Z","end":"2026-05-30T09:41:16.607962Z","steps":["trace[1497681261] 'read index received' (duration: 125.99045ms)","trace[1497681261] 'applied index is now lower than readState.Index' (duration: 67.207791ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:41:16.608206Z","caller":"traceutil/trace.go:171","msg":"trace[1148679376] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"202.505304ms","start":"2026-05-30T09:41:16.40567Z","end":"2026-05-30T09:41:16.608175Z","steps":["trace[1148679376] 'process raft request' (duration: 202.213971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:41:16.608314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.088915ms","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-30T09:41:16.608427Z","caller":"traceutil/trace.go:171","msg":"trace[848294662] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"100.251137ms","start":"2026-05-30T09:41:16.508154Z","end":"2026-05-30T09:41:16.608405Z","steps":["trace[848294662] 'agreement among raft nodes before linearized reading' (duration: 100.055245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:41:16.608612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.830638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-05-30T09:41:16.608709Z","caller":"traceutil/trace.go:171","msg":"trace[310291449] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:523; }","duration":"193.940439ms","start":"2026-05-30T09:41:16.414749Z","end":"2026-05-30T09:41:16.608689Z","steps":["trace[310291449] 'agreement among raft nodes before linearized reading' (duration: 193.378274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:41:18.317399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.580487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-05-30T09:41:18.317666Z","caller":"traceutil/trace.go:171","msg":"trace[260941534] transaction","detail":"{read_only:false; number_of_response:0; response_revision:542; }","duration":"249.134334ms","start":"2026-05-30T09:41:18.068492Z","end":"2026-05-30T09:41:18.317626Z","steps":["trace[260941534] 'process raft request' (duration: 142.258974ms)","trace[260941534] 'compare' (duration: 106.518677ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:41:18.317917Z","caller":"traceutil/trace.go:171","msg":"trace[1186959090] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"243.443159ms","start":"2026-05-30T09:41:18.074457Z","end":"2026-05-30T09:41:18.3179Z","steps":["trace[1186959090] 'process raft request' (duration: 243.349328ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:18.318185Z","caller":"traceutil/trace.go:171","msg":"trace[226844912] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"246.286666ms","start":"2026-05-30T09:41:18.071881Z","end":"2026-05-30T09:41:18.318168Z","steps":["trace[226844912] 'process raft request' (duration: 245.818662ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:18.318186Z","caller":"traceutil/trace.go:171","msg":"trace[1389640764] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"245.251497ms","start":"2026-05-30T09:41:18.072877Z","end":"2026-05-30T09:41:18.318128Z","steps":["trace[1389640764] 'process raft request' (duration: 244.867773ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:18.318352Z","caller":"traceutil/trace.go:171","msg":"trace[919741180] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"249.231746ms","start":"2026-05-30T09:41:18.069105Z","end":"2026-05-30T09:41:18.318337Z","steps":["trace[919741180] 'process raft request' (duration: 248.476629ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:18.319196Z","caller":"traceutil/trace.go:171","msg":"trace[1834090551] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"237.587021ms","start":"2026-05-30T09:41:18.081592Z","end":"2026-05-30T09:41:18.319179Z","steps":["trace[1834090551] 'process raft request' (duration: 237.384409ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:18.319516Z","caller":"traceutil/trace.go:171","msg":"trace[1169273420] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"212.170544ms","start":"2026-05-30T09:41:18.107334Z","end":"2026-05-30T09:41:18.319504Z","steps":["trace[1169273420] 'process raft request' (duration: 212.127073ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:18.319662Z","caller":"traceutil/trace.go:171","msg":"trace[1005358540] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"237.945455ms","start":"2026-05-30T09:41:18.081707Z","end":"2026-05-30T09:41:18.319653Z","steps":["trace[1005358540] 'process raft request' (duration: 237.336378ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:18.319746Z","caller":"traceutil/trace.go:171","msg":"trace[1513346563] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"230.242541ms","start":"2026-05-30T09:41:18.089436Z","end":"2026-05-30T09:41:18.319679Z","steps":["trace[1513346563] 'process raft request' (duration: 229.709765ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:18.319872Z","caller":"traceutil/trace.go:171","msg":"trace[552475240] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"231.626214ms","start":"2026-05-30T09:41:18.088237Z","end":"2026-05-30T09:41:18.319863Z","steps":["trace[552475240] 'process raft request' (duration: 230.850786ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:24.931566Z","caller":"traceutil/trace.go:171","msg":"trace[314895345] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"114.198887ms","start":"2026-05-30T09:41:24.817337Z","end":"2026-05-30T09:41:24.931536Z","steps":["trace[314895345] 'process raft request' (duration: 113.513461ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:24.939757Z","caller":"traceutil/trace.go:171","msg":"trace[851860101] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"110.27276ms","start":"2026-05-30T09:41:24.829452Z","end":"2026-05-30T09:41:24.939725Z","steps":["trace[851860101] 'process raft request' (duration: 109.971827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:41:25.463301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.893039ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:41:25.46376Z","caller":"traceutil/trace.go:171","msg":"trace[324229797] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"120.199968ms","start":"2026-05-30T09:41:25.343538Z","end":"2026-05-30T09:41:25.463738Z","steps":["trace[324229797] 'process raft request' (duration: 120.124737ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:41:25.463677Z","caller":"traceutil/trace.go:171","msg":"trace[181122334] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"474.237899ms","start":"2026-05-30T09:41:24.989411Z","end":"2026-05-30T09:41:25.463649Z","steps":["trace[181122334] 'process raft request' (duration: 280.890356ms)","trace[181122334] 'compare' (duration: 192.653895ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:41:25.463921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.833228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:41:25.463775Z","caller":"traceutil/trace.go:171","msg":"trace[1839421828] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"387.647226ms","start":"2026-05-30T09:41:25.076071Z","end":"2026-05-30T09:41:25.463718Z","steps":["trace[1839421828] 'read index received' (duration: 194.877319ms)","trace[1839421828] 'applied index is now lower than readState.Index' (duration: 192.764737ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:41:25.463986Z","caller":"traceutil/trace.go:171","msg":"trace[893786738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"387.939989ms","start":"2026-05-30T09:41:25.07603Z","end":"2026-05-30T09:41:25.46397Z","steps":["trace[893786738] 'agreement among raft nodes before linearized reading' (duration: 387.811697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:41:25.464052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:41:25.076014Z","time spent":"388.025529ms","remote":"127.0.0.1:48884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T09:41:25.465119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:41:24.989388Z","time spent":"475.649901ms","remote":"127.0.0.1:49206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:41:41.295539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.871828ms","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-30T09:41:41.295639Z","caller":"traceutil/trace.go:171","msg":"trace[1331291035] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:803; }","duration":"276.985263ms","start":"2026-05-30T09:41:41.018631Z","end":"2026-05-30T09:41:41.295616Z","steps":["trace[1331291035] 'range keys from in-memory index tree' (duration: 276.712699ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:41:41.295687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.273645ms","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-05-30T09:41:41.295757Z","caller":"traceutil/trace.go:171","msg":"trace[1699512875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:803; }","duration":"281.385181ms","start":"2026-05-30T09:41:41.014356Z","end":"2026-05-30T09:41:41.295741Z","steps":["trace[1699512875] 'range keys from in-memory index tree' (duration: 281.100666ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:41:41.29587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.394916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:41:41.295952Z","caller":"traceutil/trace.go:171","msg":"trace[395428697] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:803; }","duration":"262.508072ms","start":"2026-05-30T09:41:41.033422Z","end":"2026-05-30T09:41:41.29593Z","steps":["trace[395428697] 'count revisions from in-memory index tree' (duration: 262.333032ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:42:56.475072Z","caller":"traceutil/trace.go:171","msg":"trace[1557345299] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"250.243573ms","start":"2026-05-30T09:42:56.224805Z","end":"2026-05-30T09:42:56.475049Z","steps":["trace[1557345299] 'read index received' (duration: 175.125172ms)","trace[1557345299] 'applied index is now lower than readState.Index' (duration: 75.117371ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:42:56.475352Z","caller":"traceutil/trace.go:171","msg":"trace[1666584726] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"315.261552ms","start":"2026-05-30T09:42:56.160077Z","end":"2026-05-30T09:42:56.475339Z","steps":["trace[1666584726] 'process raft request' (duration: 239.783311ms)","trace[1666584726] 'compare' (duration: 75.07855ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:42:56.47612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.812734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T09:42:56.476218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:42:56.16005Z","time spent":"315.337813ms","remote":"127.0.0.1:49152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T09:42:56.476211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.798359ms","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-30T09:42:56.476215Z","caller":"traceutil/trace.go:171","msg":"trace[921621818] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1874; }","duration":"152.200493ms","start":"2026-05-30T09:42:56.323995Z","end":"2026-05-30T09:42:56.476195Z","steps":["trace[921621818] 'agreement among raft nodes before linearized reading' (duration: 151.764842ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:42:56.476278Z","caller":"traceutil/trace.go:171","msg":"trace[95550149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1874; }","duration":"100.894761ms","start":"2026-05-30T09:42:56.37537Z","end":"2026-05-30T09:42:56.476265Z","steps":["trace[95550149] 'agreement among raft nodes before linearized reading' (duration: 100.723247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:42:56.476332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.504035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ba72532a-6ff5-4615-b7b8-0013f009c091\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-05-30T09:42:56.476415Z","caller":"traceutil/trace.go:171","msg":"trace[1775490709] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ba72532a-6ff5-4615-b7b8-0013f009c091; range_end:; response_count:1; response_revision:1874; }","duration":"251.596797ms","start":"2026-05-30T09:42:56.224799Z","end":"2026-05-30T09:42:56.476396Z","steps":["trace[1775490709] 'agreement among raft nodes before linearized reading' (duration: 251.277899ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:25.645143Z","caller":"traceutil/trace.go:171","msg":"trace[904080143] linearizableReadLoop","detail":"{readStateIndex:2601; appliedIndex:2600; }","duration":"116.271961ms","start":"2026-05-30T09:44:25.528842Z","end":"2026-05-30T09:44:25.645114Z","steps":["trace[904080143] 'read index received' (duration: 116.031878ms)","trace[904080143] 'applied index is now lower than readState.Index' (duration: 239.123µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:44:25.64523Z","caller":"traceutil/trace.go:171","msg":"trace[648994682] transaction","detail":"{read_only:false; response_revision:2512; number_of_response:1; }","duration":"136.802806ms","start":"2026-05-30T09:44:25.508393Z","end":"2026-05-30T09:44:25.645195Z","steps":["trace[648994682] 'process raft request' (duration: 136.544032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:25.645358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.485986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:44:25.645395Z","caller":"traceutil/trace.go:171","msg":"trace[873515078] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2512; }","duration":"116.580108ms","start":"2026-05-30T09:44:25.528806Z","end":"2026-05-30T09:44:25.645386Z","steps":["trace[873515078] 'agreement among raft nodes before linearized reading' (duration: 116.478035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:25.645461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.039698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-30T09:44:25.645501Z","caller":"traceutil/trace.go:171","msg":"trace[509506971] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2512; }","duration":"111.119618ms","start":"2026-05-30T09:44:25.534368Z","end":"2026-05-30T09:44:25.645488Z","steps":["trace[509506971] 'agreement among raft nodes before linearized reading' (duration: 110.947896ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:58.429059Z","caller":"traceutil/trace.go:171","msg":"trace[1684353888] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"121.422923ms","start":"2026-05-30T09:44:58.307608Z","end":"2026-05-30T09:44:58.429031Z","steps":["trace[1684353888] 'process raft request' (duration: 121.27919ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:58.432371Z","caller":"traceutil/trace.go:171","msg":"trace[596020546] transaction","detail":"{read_only:false; response_revision:2695; number_of_response:1; }","duration":"123.618526ms","start":"2026-05-30T09:44:58.308726Z","end":"2026-05-30T09:44:58.432345Z","steps":["trace[596020546] 'process raft request' (duration: 123.465154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:58.568799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.419212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-05-30T09:44:58.568886Z","caller":"traceutil/trace.go:171","msg":"trace[2029240195] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2695; }","duration":"109.556873ms","start":"2026-05-30T09:44:58.459311Z","end":"2026-05-30T09:44:58.568868Z","steps":["trace[2029240195] 'range keys from in-memory index tree' (duration: 109.251309ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:03.853516Z","caller":"traceutil/trace.go:171","msg":"trace[700706126] linearizableReadLoop","detail":"{readStateIndex:2818; appliedIndex:2817; }","duration":"132.137768ms","start":"2026-05-30T09:45:03.721355Z","end":"2026-05-30T09:45:03.853493Z","steps":["trace[700706126] 'read index received' (duration: 131.992845ms)","trace[700706126] 'applied index is now lower than readState.Index' (duration: 141.593µs)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:45:03.853705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.31612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:45:03.85357Z","caller":"traceutil/trace.go:171","msg":"trace[1397273447] transaction","detail":"{read_only:false; response_revision:2720; number_of_response:1; }","duration":"167.532367ms","start":"2026-05-30T09:45:03.686009Z","end":"2026-05-30T09:45:03.853541Z","steps":["trace[1397273447] 'process raft request' (duration: 167.331444ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:03.853794Z","caller":"traceutil/trace.go:171","msg":"trace[807363134] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2720; }","duration":"132.454532ms","start":"2026-05-30T09:45:03.721321Z","end":"2026-05-30T09:45:03.853775Z","steps":["trace[807363134] 'agreement among raft nodes before linearized reading' (duration: 132.279589ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:48:54.715532Z","caller":"traceutil/trace.go:171","msg":"trace[2020612772] transaction","detail":"{read_only:false; response_revision:4640; number_of_response:1; }","duration":"120.496482ms","start":"2026-05-30T09:48:54.59498Z","end":"2026-05-30T09:48:54.715477Z","steps":["trace[2020612772] 'process raft request' (duration: 119.847946ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:48:54.78361Z","caller":"traceutil/trace.go:171","msg":"trace[1513773664] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"121.104817ms","start":"2026-05-30T09:48:54.662473Z","end":"2026-05-30T09:48:54.783578Z","steps":["trace[1513773664] 'process raft request' (duration: 65.862782ms)","trace[1513773664] 'compare' (duration: 54.797674ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:48:54.926697Z","caller":"traceutil/trace.go:171","msg":"trace[1253086374] transaction","detail":"{read_only:false; response_revision:4642; number_of_response:1; }","duration":"141.047452ms","start":"2026-05-30T09:48:54.785624Z","end":"2026-05-30T09:48:54.926671Z","steps":["trace[1253086374] 'process raft request' (duration: 109.937835ms)","trace[1253086374] 'compare' (duration: 30.901972ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:48:54.927069Z","caller":"traceutil/trace.go:171","msg":"trace[7956957] transaction","detail":"{read_only:false; response_revision:4643; number_of_response:1; }","duration":"129.46548ms","start":"2026-05-30T09:48:54.797553Z","end":"2026-05-30T09:48:54.927019Z","steps":["trace[7956957] 'process raft request' (duration: 129.06531ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:48:54.927258Z","caller":"traceutil/trace.go:171","msg":"trace[804007951] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"116.038362ms","start":"2026-05-30T09:48:54.811162Z","end":"2026-05-30T09:48:54.9272Z","steps":["trace[804007951] 'process raft request' (duration: 115.749945ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:48:55.27985Z","caller":"traceutil/trace.go:171","msg":"trace[207378821] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"195.147238ms","start":"2026-05-30T09:48:55.084688Z","end":"2026-05-30T09:48:55.279835Z","steps":["trace[207378821] 'process raft request' (duration: 195.024425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:48:58.327305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.184747ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-30T09:48:58.327383Z","caller":"traceutil/trace.go:171","msg":"trace[1241728658] linearizableReadLoop","detail":"{readStateIndex:4852; appliedIndex:4851; }","duration":"339.426044ms","start":"2026-05-30T09:48:57.987944Z","end":"2026-05-30T09:48:58.32737Z","steps":["trace[1241728658] 'read index received' (duration: 78.093713ms)","trace[1241728658] 'applied index is now lower than readState.Index' (duration: 261.331401ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:48:58.327441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.490535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:48:58.327462Z","caller":"traceutil/trace.go:171","msg":"trace[1255800348] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4679; }","duration":"339.518076ms","start":"2026-05-30T09:48:57.987937Z","end":"2026-05-30T09:48:58.327455Z","steps":["trace[1255800348] 'agreement among raft nodes before linearized reading' (duration: 339.467605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:48:58.327485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:48:57.987876Z","time spent":"339.605009ms","remote":"127.0.0.1:49310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-05-30T09:48:58.35158Z","caller":"traceutil/trace.go:171","msg":"trace[1560502091] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"117.939963ms","start":"2026-05-30T09:48:58.233608Z","end":"2026-05-30T09:48:58.351548Z","steps":["trace[1560502091] 'process raft request' (duration: 117.683777ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:49:01.605906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.064192ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:49:01.60604Z","caller":"traceutil/trace.go:171","msg":"trace[690134501] linearizableReadLoop","detail":"{readStateIndex:4951; appliedIndex:4950; }","duration":"259.462103ms","start":"2026-05-30T09:49:01.346554Z","end":"2026-05-30T09:49:01.606017Z","steps":["trace[690134501] 'read index received' (duration: 19.26µs)","trace[690134501] 'applied index is now lower than readState.Index' (duration: 259.441103ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:49:01.606079Z","caller":"traceutil/trace.go:171","msg":"trace[495232713] transaction","detail":"{read_only:false; response_revision:4775; number_of_response:1; }","duration":"289.018571ms","start":"2026-05-30T09:49:01.317031Z","end":"2026-05-30T09:49:01.60605Z","steps":["trace[495232713] 'process raft request' (duration: 27.684573ms)","trace[495232713] 'compare' (duration: 260.930359ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:49:01.606237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.672657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-05-30T09:49:01.606335Z","caller":"traceutil/trace.go:171","msg":"trace[1521462691] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4775; }","duration":"259.785682ms","start":"2026-05-30T09:49:01.346528Z","end":"2026-05-30T09:49:01.606314Z","steps":["trace[1521462691] 'agreement among raft nodes before linearized reading' (duration: 259.580567ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:49:01.894963Z","caller":"traceutil/trace.go:171","msg":"trace[1496765491] linearizableReadLoop","detail":"{readStateIndex:4952; appliedIndex:4951; }","duration":"288.858707ms","start":"2026-05-30T09:49:01.606077Z","end":"2026-05-30T09:49:01.894936Z","steps":["trace[1496765491] 'read index received' (duration: 288.793396ms)","trace[1496765491] 'applied index is now lower than readState.Index' (duration: 64.221µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:49:01.894997Z","caller":"traceutil/trace.go:171","msg":"trace[1321104427] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"547.868049ms","start":"2026-05-30T09:49:01.347106Z","end":"2026-05-30T09:49:01.894974Z","steps":["trace[1321104427] 'process raft request' (duration: 547.684505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:49:01.895113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:49:01.347079Z","time spent":"547.977022ms","remote":"127.0.0.1:49000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2581,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:49:01.895282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.261325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b3f4c03-19be-42df-853f-5f3c26067cc2\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-05-30T09:49:01.895414Z","caller":"traceutil/trace.go:171","msg":"trace[1770034198] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4b3f4c03-19be-42df-853f-5f3c26067cc2; range_end:; response_count:1; response_revision:4776; }","duration":"471.429649ms","start":"2026-05-30T09:49:01.42396Z","end":"2026-05-30T09:49:01.895389Z","steps":["trace[1770034198] 'agreement among raft nodes before linearized reading' (duration: 471.117362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:49:01.895464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:49:01.42394Z","time spent":"471.512802ms","remote":"127.0.0.1:49096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b3f4c03-19be-42df-853f-5f3c26067cc2\" "} {"level":"warn","ts":"2026-05-30T09:49:01.898711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.92604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b3f4c03-19be-42df-853f-5f3c26067cc2\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-05-30T09:49:01.898761Z","caller":"traceutil/trace.go:171","msg":"trace[2009717213] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4b3f4c03-19be-42df-853f-5f3c26067cc2; range_end:; response_count:1; response_revision:4778; }","duration":"241.016451ms","start":"2026-05-30T09:49:01.657734Z","end":"2026-05-30T09:49:01.89875Z","steps":["trace[2009717213] 'agreement among raft nodes before linearized reading' (duration: 240.785766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:49:01.898904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.973335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T09:49:01.89893Z","caller":"traceutil/trace.go:171","msg":"trace[729677115] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4778; }","duration":"128.002896ms","start":"2026-05-30T09:49:01.770921Z","end":"2026-05-30T09:49:01.898924Z","steps":["trace[729677115] 'agreement among raft nodes before linearized reading' (duration: 127.959105ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:49:01.898955Z","caller":"traceutil/trace.go:171","msg":"trace[1840198602] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"288.037958ms","start":"2026-05-30T09:49:01.610894Z","end":"2026-05-30T09:49:01.898932Z","steps":["trace[1840198602] 'process raft request' (duration: 287.510105ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:49:01.898962Z","caller":"traceutil/trace.go:171","msg":"trace[382636760] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"106.529722ms","start":"2026-05-30T09:49:01.792406Z","end":"2026-05-30T09:49:01.898936Z","steps":["trace[382636760] 'process raft request' (duration: 106.071501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:49:01.898766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.58164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-30T09:49:01.899444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.724354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-30T09:49:01.899484Z","caller":"traceutil/trace.go:171","msg":"trace[1208408891] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4778; }","duration":"146.822577ms","start":"2026-05-30T09:49:01.752654Z","end":"2026-05-30T09:49:01.899476Z","steps":["trace[1208408891] 'agreement among raft nodes before linearized reading' (duration: 146.602351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:49:01.899711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.962702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:49:01.899759Z","caller":"traceutil/trace.go:171","msg":"trace[527974053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4778; }","duration":"239.039534ms","start":"2026-05-30T09:49:01.660708Z","end":"2026-05-30T09:49:01.899747Z","steps":["trace[527974053] 'agreement among raft nodes before linearized reading' (duration: 238.301647ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:49:01.900096Z","caller":"traceutil/trace.go:171","msg":"trace[1148799672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4778; }","duration":"114.057182ms","start":"2026-05-30T09:49:01.785141Z","end":"2026-05-30T09:49:01.899198Z","steps":["trace[1148799672] 'agreement among raft nodes before linearized reading' (duration: 113.485469ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:50:05.268012Z","caller":"traceutil/trace.go:171","msg":"trace[1655332316] transaction","detail":"{read_only:false; response_revision:5350; number_of_response:1; }","duration":"143.223496ms","start":"2026-05-30T09:50:05.124772Z","end":"2026-05-30T09:50:05.267996Z","steps":["trace[1655332316] 'process raft request' (duration: 143.078203ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:50:19.168695Z","caller":"traceutil/trace.go:171","msg":"trace[694646457] transaction","detail":"{read_only:false; response_revision:5471; number_of_response:1; }","duration":"113.973885ms","start":"2026-05-30T09:50:19.054692Z","end":"2026-05-30T09:50:19.168666Z","steps":["trace[694646457] 'process raft request' (duration: 96.785386ms)","trace[694646457] 'compare' (duration: 16.833781ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:50:19.169164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.067415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" ","response":"range_response_count:1 size:1148"} {"level":"info","ts":"2026-05-30T09:50:19.169249Z","caller":"traceutil/trace.go:171","msg":"trace[1706242087] range","detail":"{range_begin:/registry/services/endpoints/openstack/percona-xtradb-haproxy; range_end:; response_count:1; response_revision:5471; }","duration":"100.194759ms","start":"2026-05-30T09:50:19.069026Z","end":"2026-05-30T09:50:19.169221Z","steps":["trace[1706242087] 'agreement among raft nodes before linearized reading' (duration: 99.802831ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:50:39.056883Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2909} {"level":"info","ts":"2026-05-30T09:50:39.147309Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2909,"took":"88.377105ms","hash":712187957,"current-db-size-bytes":54288384,"current-db-size":"54 MB","current-db-size-in-use-bytes":29270016,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-30T09:50:39.147388Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":712187957,"revision":2909,"compact-revision":-1} {"level":"info","ts":"2026-05-30T09:52:50.050261Z","caller":"traceutil/trace.go:171","msg":"trace[337575038] transaction","detail":"{read_only:false; response_revision:6497; number_of_response:1; }","duration":"136.376155ms","start":"2026-05-30T09:52:49.913853Z","end":"2026-05-30T09:52:50.050229Z","steps":["trace[337575038] 'process raft request' (duration: 86.006904ms)","trace[337575038] 'compare' (duration: 50.233669ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:52:50.050935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.840624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-05-30T09:52:50.051067Z","caller":"traceutil/trace.go:171","msg":"trace[1736834983] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6497; }","duration":"100.963707ms","start":"2026-05-30T09:52:49.950036Z","end":"2026-05-30T09:52:50.051Z","steps":["trace[1736834983] 'agreement among raft nodes before linearized reading' (duration: 100.189183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:52:50.309813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.214871ms","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-30T09:52:50.309889Z","caller":"traceutil/trace.go:171","msg":"trace[1199196319] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6497; }","duration":"101.335983ms","start":"2026-05-30T09:52:50.208535Z","end":"2026-05-30T09:52:50.309871Z","steps":["trace[1199196319] 'range keys from in-memory index tree' (duration: 101.023567ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:55:39.063539Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5610} {"level":"info","ts":"2026-05-30T09:55:39.144441Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5610,"took":"79.888266ms","hash":5936206,"current-db-size-bytes":54288384,"current-db-size":"54 MB","current-db-size-in-use-bytes":18296832,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-30T09:55:39.144499Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":5936206,"revision":5610,"compact-revision":2909}