{"level":"warn","ts":"2026-05-11T20:58:40.247458Z","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-11T20:58:40.247545Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-11T20:58:40.247651Z","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-11T20:58:40.247667Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-05-11T20:58:40.247789Z","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-11T20:58:40.248736Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-05-11T20:58:40.248924Z","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.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-11T20:58:40.252802Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.51806ms"} {"level":"info","ts":"2026-05-11T20:58:40.261Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-05-11T20:58:40.261072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T20:58:40.261094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-05-11T20:58:40.261107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T20:58:40.26112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-05-11T20:58:40.261155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-05-11T20:58:40.26561Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T20:58:40.266842Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T20:58:40.268053Z","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-11T20:58:40.271677Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T20:58:40.271976Z","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-11T20:58:40.271971Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T20:58:40.272071Z","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-11T20:58:40.272089Z","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-11T20:58:40.273304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-05-11T20:58:40.273426Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-05-11T20:58:40.277948Z","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-11T20:58:40.278035Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-05-11T20:58:40.278062Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-05-11T20:58:40.278313Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T20:58:40.278347Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T20:58:41.061959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T20:58:41.062026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T20:58:41.062073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-05-11T20:58:41.062092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-05-11T20:58:41.062103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-05-11T20:58:41.062119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-05-11T20:58:41.062133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-05-11T20:58:41.063041Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T20:58:41.063085Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T20:58:41.063201Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T20:58:41.063185Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T20:58:41.064123Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T20:58:41.064166Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T20:58:41.065824Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T20:58:41.065967Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T20:58:41.066008Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T20:58:41.06624Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-05-11T20:58:41.067406Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T20:58:42.519635Z","caller":"traceutil/trace.go:171","msg":"trace[1445041472] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"197.167381ms","start":"2026-05-11T20:58:42.322441Z","end":"2026-05-11T20:58:42.519608Z","steps":["trace[1445041472] 'read index received' (duration: 196.211598ms)","trace[1445041472] 'applied index is now lower than readState.Index' (duration: 954.823µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T20:58:42.51967Z","caller":"traceutil/trace.go:171","msg":"trace[244926843] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"204.083065ms","start":"2026-05-11T20:58:42.315555Z","end":"2026-05-11T20:58:42.519638Z","steps":["trace[244926843] 'process raft request' (duration: 203.078422ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:58:42.519913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.385734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T20:58:42.520064Z","caller":"traceutil/trace.go:171","msg":"trace[1975612527] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:0; response_revision:3; }","duration":"197.617088ms","start":"2026-05-11T20:58:42.322406Z","end":"2026-05-11T20:58:42.520023Z","steps":["trace[1975612527] 'agreement among raft nodes before linearized reading' (duration: 197.266883ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:58:42.527276Z","caller":"traceutil/trace.go:171","msg":"trace[1410492367] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"203.67985ms","start":"2026-05-11T20:58:42.323564Z","end":"2026-05-11T20:58:42.527244Z","steps":["trace[1410492367] 'process raft request' (duration: 203.491538ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:58:42.528433Z","caller":"traceutil/trace.go:171","msg":"trace[2042095447] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"204.126727ms","start":"2026-05-11T20:58:42.323955Z","end":"2026-05-11T20:58:42.528081Z","steps":["trace[2042095447] 'process raft request' (duration: 203.267775ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:58:42.528339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.718487ms","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-11T20:58:42.528799Z","caller":"traceutil/trace.go:171","msg":"trace[64032399] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"129.148473ms","start":"2026-05-11T20:58:42.399589Z","end":"2026-05-11T20:58:42.528738Z","steps":["trace[64032399] 'agreement among raft nodes before linearized reading' (duration: 128.437643ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:58:42.531662Z","caller":"traceutil/trace.go:171","msg":"trace[740769539] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"207.581844ms","start":"2026-05-11T20:58:42.323954Z","end":"2026-05-11T20:58:42.531536Z","steps":["trace[740769539] 'process raft request' (duration: 203.282535ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:58:42.527301Z","caller":"traceutil/trace.go:171","msg":"trace[665911021] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"203.507858ms","start":"2026-05-11T20:58:42.323771Z","end":"2026-05-11T20:58:42.527279Z","steps":["trace[665911021] 'process raft request' (duration: 203.430767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:58:42.531774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.586361ms","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-11T20:58:42.527361Z","caller":"traceutil/trace.go:171","msg":"trace[976074856] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"203.720771ms","start":"2026-05-11T20:58:42.323619Z","end":"2026-05-11T20:58:42.527339Z","steps":["trace[976074856] 'process raft request' (duration: 203.559958ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:58:42.531954Z","caller":"traceutil/trace.go:171","msg":"trace[1802165410] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"135.730753ms","start":"2026-05-11T20:58:42.396126Z","end":"2026-05-11T20:58:42.531857Z","steps":["trace[1802165410] 'agreement among raft nodes before linearized reading' (duration: 132.697652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:58:42.53169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.56988ms","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-11T20:58:42.532111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.681683ms","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-11T20:58:42.531665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.987009ms","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":"info","ts":"2026-05-11T20:58:42.532152Z","caller":"traceutil/trace.go:171","msg":"trace[1596796981] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"157.741183ms","start":"2026-05-11T20:58:42.374393Z","end":"2026-05-11T20:58:42.532134Z","steps":["trace[1596796981] 'agreement among raft nodes before linearized reading' (duration: 157.267727ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:58:42.527373Z","caller":"traceutil/trace.go:171","msg":"trace[1368757253] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"186.241762ms","start":"2026-05-11T20:58:42.34112Z","end":"2026-05-11T20:58:42.527362Z","steps":["trace[1368757253] 'process raft request' (duration: 186.178811ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:58:42.53326Z","caller":"traceutil/trace.go:171","msg":"trace[1665617692] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"208.591407ms","start":"2026-05-11T20:58:42.323561Z","end":"2026-05-11T20:58:42.532152Z","steps":["trace[1665617692] 'agreement among raft nodes before linearized reading' (duration: 207.799037ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:58:42.533273Z","caller":"traceutil/trace.go:171","msg":"trace[990138956] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"136.27795ms","start":"2026-05-11T20:58:42.39616Z","end":"2026-05-11T20:58:42.532438Z","steps":["trace[990138956] 'agreement among raft nodes before linearized reading' (duration: 132.397167ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:58:42.533438Z","caller":"traceutil/trace.go:171","msg":"trace[785859611] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"207.410011ms","start":"2026-05-11T20:58:42.324298Z","end":"2026-05-11T20:58:42.531708Z","steps":["trace[785859611] 'process raft request' (duration: 202.95173ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:58:42.533455Z","caller":"traceutil/trace.go:171","msg":"trace[876429706] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"193.32628ms","start":"2026-05-11T20:58:42.338396Z","end":"2026-05-11T20:58:42.531723Z","steps":["trace[876429706] 'process raft request' (duration: 188.882469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:58:42.531726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.64326ms","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-11T20:58:42.533652Z","caller":"traceutil/trace.go:171","msg":"trace[827632561] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"209.788613ms","start":"2026-05-11T20:58:42.323833Z","end":"2026-05-11T20:58:42.533622Z","steps":["trace[827632561] 'agreement among raft nodes before linearized reading' (duration: 203.583229ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:58:42.533863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.62885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T20:58:42.535691Z","caller":"traceutil/trace.go:171","msg":"trace[1689857214] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"163.081386ms","start":"2026-05-11T20:58:42.371155Z","end":"2026-05-11T20:58:42.534237Z","steps":["trace[1689857214] 'agreement among raft nodes before linearized reading' (duration: 156.239072ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:15.731733Z","caller":"traceutil/trace.go:171","msg":"trace[672803326] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"139.953327ms","start":"2026-05-11T20:59:15.591762Z","end":"2026-05-11T20:59:15.731715Z","steps":["trace[672803326] 'process raft request' (duration: 139.836266ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:15.891595Z","caller":"traceutil/trace.go:171","msg":"trace[1276607421] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"162.075097ms","start":"2026-05-11T20:59:15.729482Z","end":"2026-05-11T20:59:15.891557Z","steps":["trace[1276607421] 'process raft request' (duration: 159.737057ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:16.266015Z","caller":"traceutil/trace.go:171","msg":"trace[463392083] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"367.952341ms","start":"2026-05-11T20:59:15.898029Z","end":"2026-05-11T20:59:16.265981Z","steps":["trace[463392083] 'process raft request' (duration: 348.547545ms)","trace[463392083] 'compare' (duration: 19.281315ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T20:59:16.266604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T20:59:15.898009Z","time spent":"368.083682ms","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T20:59:16.318849Z","caller":"traceutil/trace.go:171","msg":"trace[1751155605] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"375.938205ms","start":"2026-05-11T20:59:15.942863Z","end":"2026-05-11T20:59:16.318802Z","steps":["trace[1751155605] 'process raft request' (duration: 375.761783ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:16.318861Z","caller":"traceutil/trace.go:171","msg":"trace[1646078496] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"268.383212ms","start":"2026-05-11T20:59:16.050449Z","end":"2026-05-11T20:59:16.318832Z","steps":["trace[1646078496] 'process raft request' (duration: 268.336652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:59:16.319115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T20:59:15.942841Z","time spent":"376.185177ms","remote":"127.0.0.1:35384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T20:59:16.318893Z","caller":"traceutil/trace.go:171","msg":"trace[267197745] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"320.514527ms","start":"2026-05-11T20:59:15.998342Z","end":"2026-05-11T20:59:16.318856Z","steps":["trace[267197745] 'process raft request' (duration: 320.391656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:59:16.31937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T20:59:15.998318Z","time spent":"320.983441ms","remote":"127.0.0.1:35050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4584,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T20:59:17.150088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.017415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-11T20:59:17.150187Z","caller":"traceutil/trace.go:171","msg":"trace[1642108424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:621; }","duration":"619.122386ms","start":"2026-05-11T20:59:16.531033Z","end":"2026-05-11T20:59:17.150155Z","steps":["trace[1642108424] 'range keys from in-memory index tree' (duration: 618.845503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:59:17.150233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T20:59:16.530977Z","time spent":"619.246096ms","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-11T20:59:17.152105Z","caller":"traceutil/trace.go:171","msg":"trace[1593923719] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"299.732048ms","start":"2026-05-11T20:59:16.852341Z","end":"2026-05-11T20:59:17.152073Z","steps":["trace[1593923719] 'read index received' (duration: 298.445667ms)","trace[1593923719] 'applied index is now lower than readState.Index' (duration: 1.285121ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T20:59:17.15223Z","caller":"traceutil/trace.go:171","msg":"trace[1280776881] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"418.26987ms","start":"2026-05-11T20:59:16.733899Z","end":"2026-05-11T20:59:17.152168Z","steps":["trace[1280776881] 'process raft request' (duration: 417.16268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:59:17.152301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.142002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T20:59:17.152333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.98213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T20:59:17.152365Z","caller":"traceutil/trace.go:171","msg":"trace[566067436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"293.240352ms","start":"2026-05-11T20:59:16.859106Z","end":"2026-05-11T20:59:17.152347Z","steps":["trace[566067436] 'agreement among raft nodes before linearized reading' (duration: 293.131171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:59:17.152384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T20:59:16.733835Z","time spent":"418.464322ms","remote":"127.0.0.1:34988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T20:59:17.152402Z","caller":"traceutil/trace.go:171","msg":"trace[1437131311] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:622; }","duration":"300.094641ms","start":"2026-05-11T20:59:16.852291Z","end":"2026-05-11T20:59:17.152386Z","steps":["trace[1437131311] 'agreement among raft nodes before linearized reading' (duration: 299.879049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:59:17.152433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T20:59:16.852272Z","time spent":"300.154311ms","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-11T20:59:17.152448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.751253ms","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-11T20:59:17.152513Z","caller":"traceutil/trace.go:171","msg":"trace[262383774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"213.855325ms","start":"2026-05-11T20:59:16.938641Z","end":"2026-05-11T20:59:17.152496Z","steps":["trace[262383774] 'agreement among raft nodes before linearized reading' (duration: 213.651923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:59:21.971882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.441327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T20:59:21.971982Z","caller":"traceutil/trace.go:171","msg":"trace[994571957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:697; }","duration":"112.620038ms","start":"2026-05-11T20:59:21.859343Z","end":"2026-05-11T20:59:21.971963Z","steps":["trace[994571957] 'range keys from in-memory index tree' (duration: 112.345966ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:23.341303Z","caller":"traceutil/trace.go:171","msg":"trace[689311495] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"118.736232ms","start":"2026-05-11T20:59:23.222539Z","end":"2026-05-11T20:59:23.341275Z","steps":["trace[689311495] 'process raft request' (duration: 118.52078ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:29.438612Z","caller":"traceutil/trace.go:171","msg":"trace[1440671277] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"125.672022ms","start":"2026-05-11T20:59:29.312919Z","end":"2026-05-11T20:59:29.438591Z","steps":["trace[1440671277] 'process raft request' (duration: 125.542281ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:29.441349Z","caller":"traceutil/trace.go:171","msg":"trace[49542801] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:796; }","duration":"113.926472ms","start":"2026-05-11T20:59:29.3274Z","end":"2026-05-11T20:59:29.441326Z","steps":["trace[49542801] 'read index received' (duration: 111.06676ms)","trace[49542801] 'applied index is now lower than readState.Index' (duration: 2.858442ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T20:59:29.441603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.166084ms","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-11T20:59:29.441714Z","caller":"traceutil/trace.go:171","msg":"trace[975473023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:768; }","duration":"114.341475ms","start":"2026-05-11T20:59:29.327351Z","end":"2026-05-11T20:59:29.441693Z","steps":["trace[975473023] 'agreement among raft nodes before linearized reading' (duration: 114.043363ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:32.523834Z","caller":"traceutil/trace.go:171","msg":"trace[1617262643] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"102.74686ms","start":"2026-05-11T20:59:32.421062Z","end":"2026-05-11T20:59:32.523809Z","steps":["trace[1617262643] 'read index received' (duration: 102.545979ms)","trace[1617262643] 'applied index is now lower than readState.Index' (duration: 200.101µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T20:59:32.523879Z","caller":"traceutil/trace.go:171","msg":"trace[1501374226] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"184.471763ms","start":"2026-05-11T20:59:32.339385Z","end":"2026-05-11T20:59:32.523857Z","steps":["trace[1501374226] 'process raft request' (duration: 184.281001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:59:32.524129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.046693ms","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-05-11T20:59:32.524183Z","caller":"traceutil/trace.go:171","msg":"trace[1494503643] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:785; }","duration":"103.132423ms","start":"2026-05-11T20:59:32.421038Z","end":"2026-05-11T20:59:32.52417Z","steps":["trace[1494503643] 'agreement among raft nodes before linearized reading' (duration: 102.872911ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:38.945202Z","caller":"traceutil/trace.go:171","msg":"trace[850440233] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"190.661506ms","start":"2026-05-11T20:59:38.754519Z","end":"2026-05-11T20:59:38.94518Z","steps":["trace[850440233] 'process raft request' (duration: 189.668059ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:38.946038Z","caller":"traceutil/trace.go:171","msg":"trace[1982295116] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"181.829323ms","start":"2026-05-11T20:59:38.764172Z","end":"2026-05-11T20:59:38.946001Z","steps":["trace[1982295116] 'process raft request' (duration: 181.690382ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:40.818342Z","caller":"traceutil/trace.go:171","msg":"trace[734834185] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"160.241374ms","start":"2026-05-11T20:59:40.658051Z","end":"2026-05-11T20:59:40.818293Z","steps":["trace[734834185] 'process raft request' (duration: 149.359566ms)","trace[734834185] 'compare' (duration: 10.513135ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T20:59:45.364539Z","caller":"traceutil/trace.go:171","msg":"trace[1145157383] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"165.190859ms","start":"2026-05-11T20:59:45.199321Z","end":"2026-05-11T20:59:45.364512Z","steps":["trace[1145157383] 'process raft request' (duration: 120.643169ms)","trace[1145157383] 'compare' (duration: 44.431679ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T20:59:45.366244Z","caller":"traceutil/trace.go:171","msg":"trace[1590553850] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"166.429318ms","start":"2026-05-11T20:59:45.199782Z","end":"2026-05-11T20:59:45.366212Z","steps":["trace[1590553850] 'process raft request' (duration: 166.175176ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:45.366348Z","caller":"traceutil/trace.go:171","msg":"trace[1838373686] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"166.518489ms","start":"2026-05-11T20:59:45.199806Z","end":"2026-05-11T20:59:45.366325Z","steps":["trace[1838373686] 'process raft request' (duration: 166.335087ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T20:59:59.349488Z","caller":"traceutil/trace.go:171","msg":"trace[719990879] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"358.694171ms","start":"2026-05-11T20:59:58.990763Z","end":"2026-05-11T20:59:59.349458Z","steps":["trace[719990879] 'process raft request' (duration: 358.535575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T20:59:59.349641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T20:59:58.990737Z","time spent":"358.827047ms","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T21:00:45.518702Z","caller":"traceutil/trace.go:171","msg":"trace[1024318565] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"494.834741ms","start":"2026-05-11T21:00:45.023847Z","end":"2026-05-11T21:00:45.518681Z","steps":["trace[1024318565] 'process raft request' (duration: 494.726139ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:00:45.518734Z","caller":"traceutil/trace.go:171","msg":"trace[1933261050] linearizableReadLoop","detail":"{readStateIndex:1920; appliedIndex:1920; }","duration":"455.698182ms","start":"2026-05-11T21:00:45.062995Z","end":"2026-05-11T21:00:45.518693Z","steps":["trace[1933261050] 'read index received' (duration: 455.686601ms)","trace[1933261050] 'applied index is now lower than readState.Index' (duration: 9.591µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:00:45.518831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.023828Z","time spent":"494.940653ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:00:45.518928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.906187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-638b54ba-51c5-40ec-82b5-d1d6d457b516\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-05-11T21:00:45.518982Z","caller":"traceutil/trace.go:171","msg":"trace[1673181799] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-638b54ba-51c5-40ec-82b5-d1d6d457b516; range_end:; response_count:1; response_revision:1848; }","duration":"456.04576ms","start":"2026-05-11T21:00:45.062921Z","end":"2026-05-11T21:00:45.518967Z","steps":["trace[1673181799] 'agreement among raft nodes before linearized reading' (duration: 455.914707ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:45.51902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.062901Z","time spent":"456.110671ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3766,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-638b54ba-51c5-40ec-82b5-d1d6d457b516\" "} {"level":"info","ts":"2026-05-11T21:00:45.534595Z","caller":"traceutil/trace.go:171","msg":"trace[357292958] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"230.733087ms","start":"2026-05-11T21:00:45.303833Z","end":"2026-05-11T21:00:45.534566Z","steps":["trace[357292958] 'process raft request' (duration: 230.602323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:45.534624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.298609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T21:00:45.534748Z","caller":"traceutil/trace.go:171","msg":"trace[1725804720] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1849; }","duration":"327.471854ms","start":"2026-05-11T21:00:45.207261Z","end":"2026-05-11T21:00:45.534733Z","steps":["trace[1725804720] 'agreement among raft nodes before linearized reading' (duration: 327.296079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:45.534796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.207236Z","time spent":"327.550486ms","remote":"127.0.0.1:33958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-11T21:00:45.9812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.895928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T21:00:45.981276Z","caller":"traceutil/trace.go:171","msg":"trace[1753553114] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1922; }","duration":"353.079979ms","start":"2026-05-11T21:00:45.628184Z","end":"2026-05-11T21:00:45.981264Z","steps":["trace[1753553114] 'read index received' (duration: 222.961345ms)","trace[1753553114] 'applied index is now lower than readState.Index' (duration: 130.117544ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:00:45.981352Z","caller":"traceutil/trace.go:171","msg":"trace[204207733] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"353.406976ms","start":"2026-05-11T21:00:45.627918Z","end":"2026-05-11T21:00:45.981324Z","steps":["trace[204207733] 'process raft request' (duration: 223.216581ms)","trace[204207733] 'compare' (duration: 129.804346ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:00:45.981401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.218832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10982"} {"level":"info","ts":"2026-05-11T21:00:45.98142Z","caller":"traceutil/trace.go:171","msg":"trace[849496013] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1851; }","duration":"353.283914ms","start":"2026-05-11T21:00:45.62813Z","end":"2026-05-11T21:00:45.981414Z","steps":["trace[849496013] 'agreement among raft nodes before linearized reading' (duration: 353.184911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:45.981442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.628091Z","time spent":"353.345815ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":11004,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"warn","ts":"2026-05-11T21:00:45.98146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.627896Z","time spent":"353.504049ms","remote":"127.0.0.1:35048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T21:00:46.027057Z","caller":"traceutil/trace.go:171","msg":"trace[523818782] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"398.598441ms","start":"2026-05-11T21:00:45.628392Z","end":"2026-05-11T21:00:46.02699Z","steps":["trace[523818782] 'process raft request' (duration: 398.401526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:46.027113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.714395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T21:00:46.0272Z","caller":"traceutil/trace.go:171","msg":"trace[2102076829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1857; }","duration":"168.91912ms","start":"2026-05-11T21:00:45.85826Z","end":"2026-05-11T21:00:46.027179Z","steps":["trace[2102076829] 'agreement among raft nodes before linearized reading' (duration: 168.742476ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:00:46.027243Z","caller":"traceutil/trace.go:171","msg":"trace[2074866977] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"398.923989ms","start":"2026-05-11T21:00:45.628301Z","end":"2026-05-11T21:00:46.027225Z","steps":["trace[2074866977] 'process raft request' (duration: 398.265953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:46.02727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.628384Z","time spent":"398.788586ms","remote":"127.0.0.1:35158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:00:46.027356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.62828Z","time spent":"399.009491ms","remote":"127.0.0.1:35158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T21:00:46.027506Z","caller":"traceutil/trace.go:171","msg":"trace[450994813] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"391.135136ms","start":"2026-05-11T21:00:45.636342Z","end":"2026-05-11T21:00:46.027477Z","steps":["trace[450994813] 'process raft request' (duration: 390.476659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:46.027611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.63633Z","time spent":"391.213888ms","remote":"127.0.0.1:35142","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-05-11T21:00:46.027861Z","caller":"traceutil/trace.go:171","msg":"trace[2012205197] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"241.253073ms","start":"2026-05-11T21:00:45.786595Z","end":"2026-05-11T21:00:46.027848Z","steps":["trace[2012205197] 'process raft request' (duration: 240.243228ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:00:46.027838Z","caller":"traceutil/trace.go:171","msg":"trace[862193688] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"399.463732ms","start":"2026-05-11T21:00:45.628331Z","end":"2026-05-11T21:00:46.027795Z","steps":["trace[862193688] 'process raft request' (duration: 398.427527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:46.027999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.628314Z","time spent":"399.601125ms","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:00:46.026979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.926156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-11T21:00:46.028092Z","caller":"traceutil/trace.go:171","msg":"trace[733226435] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1857; }","duration":"370.072054ms","start":"2026-05-11T21:00:45.657992Z","end":"2026-05-11T21:00:46.028064Z","steps":["trace[733226435] 'agreement among raft nodes before linearized reading' (duration: 368.872574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:46.028164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.65797Z","time spent":"370.163186ms","remote":"127.0.0.1:39982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-11T21:00:46.028325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.326976ms","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-11T21:00:46.028373Z","caller":"traceutil/trace.go:171","msg":"trace[62220784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1857; }","duration":"185.414458ms","start":"2026-05-11T21:00:45.842947Z","end":"2026-05-11T21:00:46.028361Z","steps":["trace[62220784] 'agreement among raft nodes before linearized reading' (duration: 185.264605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:46.028441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.784612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-11T21:00:46.028463Z","caller":"traceutil/trace.go:171","msg":"trace[798781993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1857; }","duration":"186.860655ms","start":"2026-05-11T21:00:45.841597Z","end":"2026-05-11T21:00:46.028458Z","steps":["trace[798781993] 'agreement among raft nodes before linearized reading' (duration: 186.762012ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:00:46.028521Z","caller":"traceutil/trace.go:171","msg":"trace[117036926] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"400.19401ms","start":"2026-05-11T21:00:45.628319Z","end":"2026-05-11T21:00:46.028513Z","steps":["trace[117036926] 'process raft request' (duration: 398.389786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:46.028546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.302622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T21:00:46.028605Z","caller":"traceutil/trace.go:171","msg":"trace[1351626384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1857; }","duration":"182.388954ms","start":"2026-05-11T21:00:45.846204Z","end":"2026-05-11T21:00:46.028593Z","steps":["trace[1351626384] 'agreement among raft nodes before linearized reading' (duration: 182.20923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:00:46.028572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:00:45.62831Z","time spent":"400.226321ms","remote":"127.0.0.1:35048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T21:01:01.220603Z","caller":"traceutil/trace.go:171","msg":"trace[1870855612] linearizableReadLoop","detail":"{readStateIndex:2058; appliedIndex:2057; }","duration":"173.213355ms","start":"2026-05-11T21:01:01.047366Z","end":"2026-05-11T21:01:01.220579Z","steps":["trace[1870855612] 'read index received' (duration: 173.01698ms)","trace[1870855612] 'applied index is now lower than readState.Index' (duration: 195.305µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:01:01.220698Z","caller":"traceutil/trace.go:171","msg":"trace[1285225951] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"173.44016ms","start":"2026-05-11T21:01:01.047229Z","end":"2026-05-11T21:01:01.220669Z","steps":["trace[1285225951] 'process raft request' (duration: 173.125413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:01:01.220777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.386578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-11T21:01:01.220798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.074097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T21:01:01.220849Z","caller":"traceutil/trace.go:171","msg":"trace[372079109] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1981; }","duration":"173.496761ms","start":"2026-05-11T21:01:01.047337Z","end":"2026-05-11T21:01:01.220834Z","steps":["trace[372079109] 'agreement among raft nodes before linearized reading' (duration: 173.352688ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:01:01.220882Z","caller":"traceutil/trace.go:171","msg":"trace[1237064596] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1981; }","duration":"170.19966ms","start":"2026-05-11T21:01:01.050665Z","end":"2026-05-11T21:01:01.220864Z","steps":["trace[1237064596] 'agreement among raft nodes before linearized reading' (duration: 170.064747ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:01:23.97209Z","caller":"traceutil/trace.go:171","msg":"trace[55367141] linearizableReadLoop","detail":"{readStateIndex:2194; appliedIndex:2193; }","duration":"111.953922ms","start":"2026-05-11T21:01:23.860112Z","end":"2026-05-11T21:01:23.972066Z","steps":["trace[55367141] 'read index received' (duration: 111.730858ms)","trace[55367141] 'applied index is now lower than readState.Index' (duration: 219.814µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:01:23.972736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.130156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T21:01:23.972805Z","caller":"traceutil/trace.go:171","msg":"trace[624854139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2112; }","duration":"112.727826ms","start":"2026-05-11T21:01:23.860056Z","end":"2026-05-11T21:01:23.972784Z","steps":["trace[624854139] 'agreement among raft nodes before linearized reading' (duration: 112.131266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:01:24.38818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.164024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T21:01:24.388419Z","caller":"traceutil/trace.go:171","msg":"trace[1295335415] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"223.843205ms","start":"2026-05-11T21:01:24.164548Z","end":"2026-05-11T21:01:24.388391Z","steps":["trace[1295335415] 'process raft request' (duration: 66.367086ms)","trace[1295335415] 'compare' (duration: 157.011611ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:01:24.388871Z","caller":"traceutil/trace.go:171","msg":"trace[1949238100] linearizableReadLoop","detail":"{readStateIndex:2198; appliedIndex:2195; }","duration":"177.083453ms","start":"2026-05-11T21:01:24.211768Z","end":"2026-05-11T21:01:24.388852Z","steps":["trace[1949238100] 'read index received' (duration: 19.215926ms)","trace[1949238100] 'applied index is now lower than readState.Index' (duration: 157.866377ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:01:24.388977Z","caller":"traceutil/trace.go:171","msg":"trace[536269923] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"221.993772ms","start":"2026-05-11T21:01:24.166949Z","end":"2026-05-11T21:01:24.388943Z","steps":["trace[536269923] 'process raft request' (duration: 221.351891ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:01:24.388982Z","caller":"traceutil/trace.go:171","msg":"trace[1675444678] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"179.961995ms","start":"2026-05-11T21:01:24.208966Z","end":"2026-05-11T21:01:24.388928Z","steps":["trace[1675444678] 'process raft request' (duration: 179.808542ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:01:24.389092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.312537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-11T21:01:24.389133Z","caller":"traceutil/trace.go:171","msg":"trace[216997145] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2116; }","duration":"177.4343ms","start":"2026-05-11T21:01:24.211688Z","end":"2026-05-11T21:01:24.389122Z","steps":["trace[216997145] 'agreement among raft nodes before linearized reading' (duration: 177.286067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:01:24.38914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.191337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-11T21:01:24.389202Z","caller":"traceutil/trace.go:171","msg":"trace[701720229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2116; }","duration":"115.271719ms","start":"2026-05-11T21:01:24.273914Z","end":"2026-05-11T21:01:24.389186Z","steps":["trace[701720229] 'agreement among raft nodes before linearized reading' (duration: 115.116286ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:01:24.389336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.807066ms","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-11T21:01:24.389386Z","caller":"traceutil/trace.go:171","msg":"trace[873228959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2116; }","duration":"116.915348ms","start":"2026-05-11T21:01:24.272457Z","end":"2026-05-11T21:01:24.389372Z","steps":["trace[873228959] 'agreement among raft nodes before linearized reading' (duration: 116.731745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:01:24.389287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.87147ms","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-11T21:01:24.389671Z","caller":"traceutil/trace.go:171","msg":"trace[1913206843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2116; }","duration":"121.325298ms","start":"2026-05-11T21:01:24.268323Z","end":"2026-05-11T21:01:24.389648Z","steps":["trace[1913206843] 'agreement among raft nodes before linearized reading' (duration: 120.710137ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:01:24.671326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.571957ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T21:01:24.671742Z","caller":"traceutil/trace.go:171","msg":"trace[2014137548] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"277.407842ms","start":"2026-05-11T21:01:24.394316Z","end":"2026-05-11T21:01:24.671724Z","steps":["trace[2014137548] 'process raft request' (duration: 106.363937ms)","trace[2014137548] 'compare' (duration: 170.475035ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:01:24.672056Z","caller":"traceutil/trace.go:171","msg":"trace[1627706151] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"276.824492ms","start":"2026-05-11T21:01:24.395215Z","end":"2026-05-11T21:01:24.672039Z","steps":["trace[1627706151] 'process raft request' (duration: 276.73211ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:01:24.672255Z","caller":"traceutil/trace.go:171","msg":"trace[1886526641] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"277.311901ms","start":"2026-05-11T21:01:24.394909Z","end":"2026-05-11T21:01:24.67222Z","steps":["trace[1886526641] 'process raft request' (duration: 276.830113ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:01:24.672341Z","caller":"traceutil/trace.go:171","msg":"trace[1232256455] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"271.793952ms","start":"2026-05-11T21:01:24.400517Z","end":"2026-05-11T21:01:24.672311Z","steps":["trace[1232256455] 'process raft request' (duration: 271.471656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:01:25.489657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.111464ms","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-11T21:01:25.489732Z","caller":"traceutil/trace.go:171","msg":"trace[187622925] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2122; }","duration":"171.235896ms","start":"2026-05-11T21:01:25.318478Z","end":"2026-05-11T21:01:25.489714Z","steps":["trace[187622925] 'range keys from in-memory index tree' (duration: 170.938461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:05:29.397462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.788456ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-11T21:05:29.39769Z","caller":"traceutil/trace.go:171","msg":"trace[1391391977] linearizableReadLoop","detail":"{readStateIndex:3757; appliedIndex:3756; }","duration":"113.327972ms","start":"2026-05-11T21:05:29.284342Z","end":"2026-05-11T21:05:29.39767Z","steps":["trace[1391391977] 'read index received' (duration: 56.361µs)","trace[1391391977] 'applied index is now lower than readState.Index' (duration: 113.270081ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:05:29.397838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.493757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-cookie-secret\" ","response":"range_response_count:1 size:1225"} {"level":"info","ts":"2026-05-11T21:05:29.397869Z","caller":"traceutil/trace.go:171","msg":"trace[237276888] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-cookie-secret; range_end:; response_count:1; response_revision:3618; }","duration":"113.568699ms","start":"2026-05-11T21:05:29.284289Z","end":"2026-05-11T21:05:29.397857Z","steps":["trace[237276888] 'agreement among raft nodes before linearized reading' (duration: 113.444276ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:05:29.433924Z","caller":"traceutil/trace.go:171","msg":"trace[648247728] transaction","detail":"{read_only:false; response_revision:3620; number_of_response:1; }","duration":"113.437215ms","start":"2026-05-11T21:05:29.320462Z","end":"2026-05-11T21:05:29.433899Z","steps":["trace[648247728] 'process raft request' (duration: 113.303722ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:05:41.624777Z","caller":"traceutil/trace.go:171","msg":"trace[464950114] linearizableReadLoop","detail":"{readStateIndex:3840; appliedIndex:3839; }","duration":"140.793937ms","start":"2026-05-11T21:05:41.483958Z","end":"2026-05-11T21:05:41.624752Z","steps":["trace[464950114] 'read index received' (duration: 66.621111ms)","trace[464950114] 'applied index is now lower than readState.Index' (duration: 74.171196ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:05:41.62481Z","caller":"traceutil/trace.go:171","msg":"trace[50114002] transaction","detail":"{read_only:false; response_revision:3699; number_of_response:1; }","duration":"128.155557ms","start":"2026-05-11T21:05:41.49663Z","end":"2026-05-11T21:05:41.624785Z","steps":["trace[50114002] 'process raft request' (duration: 128.115177ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:05:41.624922Z","caller":"traceutil/trace.go:171","msg":"trace[1694859532] transaction","detail":"{read_only:false; response_revision:3697; number_of_response:1; }","duration":"180.318054ms","start":"2026-05-11T21:05:41.444589Z","end":"2026-05-11T21:05:41.624907Z","steps":["trace[1694859532] 'process raft request' (duration: 105.914403ms)","trace[1694859532] 'compare' (duration: 74.059363ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:05:41.624916Z","caller":"traceutil/trace.go:171","msg":"trace[1901341035] transaction","detail":"{read_only:false; response_revision:3698; number_of_response:1; }","duration":"133.005476ms","start":"2026-05-11T21:05:41.491869Z","end":"2026-05-11T21:05:41.624874Z","steps":["trace[1901341035] 'process raft request' (duration: 132.826111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:05:41.625007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.028192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/kube-prometheus-stack.18ae9ed5350c38a3\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-05-11T21:05:41.625057Z","caller":"traceutil/trace.go:171","msg":"trace[783939638] range","detail":"{range_begin:/registry/events/default/kube-prometheus-stack.18ae9ed5350c38a3; range_end:; response_count:1; response_revision:3699; }","duration":"141.113425ms","start":"2026-05-11T21:05:41.483926Z","end":"2026-05-11T21:05:41.625039Z","steps":["trace[783939638] 'agreement among raft nodes before linearized reading' (duration: 140.92788ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:05:41.668053Z","caller":"traceutil/trace.go:171","msg":"trace[1653244092] transaction","detail":"{read_only:false; response_revision:3700; number_of_response:1; }","duration":"115.278311ms","start":"2026-05-11T21:05:41.552764Z","end":"2026-05-11T21:05:41.668043Z","steps":["trace[1653244092] 'process raft request' (duration: 115.196279ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:05:42.016767Z","caller":"traceutil/trace.go:171","msg":"trace[705106429] linearizableReadLoop","detail":"{readStateIndex:3857; appliedIndex:3854; }","duration":"157.451834ms","start":"2026-05-11T21:05:41.859284Z","end":"2026-05-11T21:05:42.016736Z","steps":["trace[705106429] 'read index received' (duration: 81.412884ms)","trace[705106429] 'applied index is now lower than readState.Index' (duration: 76.03828ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:05:42.01686Z","caller":"traceutil/trace.go:171","msg":"trace[1473162984] transaction","detail":"{read_only:false; response_revision:3712; number_of_response:1; }","duration":"254.13436ms","start":"2026-05-11T21:05:41.762717Z","end":"2026-05-11T21:05:42.016851Z","steps":["trace[1473162984] 'process raft request' (duration: 178.008367ms)","trace[1473162984] 'compare' (duration: 75.639331ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:05:42.017168Z","caller":"traceutil/trace.go:171","msg":"trace[321939391] transaction","detail":"{read_only:false; response_revision:3713; number_of_response:1; }","duration":"253.969995ms","start":"2026-05-11T21:05:41.76315Z","end":"2026-05-11T21:05:42.01712Z","steps":["trace[321939391] 'process raft request' (duration: 253.508944ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:05:42.017052Z","caller":"traceutil/trace.go:171","msg":"trace[2030389378] transaction","detail":"{read_only:false; response_revision:3714; number_of_response:1; }","duration":"248.961352ms","start":"2026-05-11T21:05:41.767947Z","end":"2026-05-11T21:05:42.016908Z","steps":["trace[2030389378] 'process raft request' (duration: 248.742287ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:05:42.017579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.287484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T21:05:42.017675Z","caller":"traceutil/trace.go:171","msg":"trace[637740860] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3714; }","duration":"158.391166ms","start":"2026-05-11T21:05:41.85927Z","end":"2026-05-11T21:05:42.017661Z","steps":["trace[637740860] 'agreement among raft nodes before linearized reading' (duration: 158.256783ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:05:42.274311Z","caller":"traceutil/trace.go:171","msg":"trace[1438725853] transaction","detail":"{read_only:false; response_revision:3718; number_of_response:1; }","duration":"167.842544ms","start":"2026-05-11T21:05:42.106432Z","end":"2026-05-11T21:05:42.274275Z","steps":["trace[1438725853] 'process raft request' (duration: 141.430179ms)","trace[1438725853] 'compare' (duration: 26.23018ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:06:30.276435Z","caller":"traceutil/trace.go:171","msg":"trace[1498531080] transaction","detail":"{read_only:false; response_revision:4452; number_of_response:1; }","duration":"170.161063ms","start":"2026-05-11T21:06:30.106254Z","end":"2026-05-11T21:06:30.276415Z","steps":["trace[1498531080] 'process raft request' (duration: 169.99277ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:30.284737Z","caller":"traceutil/trace.go:171","msg":"trace[233510115] transaction","detail":"{read_only:false; response_revision:4453; number_of_response:1; }","duration":"147.049902ms","start":"2026-05-11T21:06:30.137657Z","end":"2026-05-11T21:06:30.284707Z","steps":["trace[233510115] 'process raft request' (duration: 146.646223ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:33.925457Z","caller":"traceutil/trace.go:171","msg":"trace[575126969] transaction","detail":"{read_only:false; response_revision:4511; number_of_response:1; }","duration":"206.281767ms","start":"2026-05-11T21:06:33.719156Z","end":"2026-05-11T21:06:33.925438Z","steps":["trace[575126969] 'process raft request' (duration: 206.149694ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:33.929138Z","caller":"traceutil/trace.go:171","msg":"trace[796985231] transaction","detail":"{read_only:false; response_revision:4512; number_of_response:1; }","duration":"130.236068ms","start":"2026-05-11T21:06:33.798882Z","end":"2026-05-11T21:06:33.929118Z","steps":["trace[796985231] 'process raft request' (duration: 129.633256ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:35.937078Z","caller":"traceutil/trace.go:171","msg":"trace[1724240667] transaction","detail":"{read_only:false; response_revision:4551; number_of_response:1; }","duration":"126.660109ms","start":"2026-05-11T21:06:35.810376Z","end":"2026-05-11T21:06:35.937036Z","steps":["trace[1724240667] 'process raft request' (duration: 126.369643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:36.050611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.520503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-djg9g-tls\" ","response":"range_response_count:1 size:2130"} {"level":"info","ts":"2026-05-11T21:06:36.050675Z","caller":"traceutil/trace.go:171","msg":"trace[1834194175] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-djg9g-tls; range_end:; response_count:1; response_revision:4556; }","duration":"105.597134ms","start":"2026-05-11T21:06:35.945062Z","end":"2026-05-11T21:06:36.050659Z","steps":["trace[1834194175] 'agreement among raft nodes before linearized reading' (duration: 105.484401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:36.050511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.601185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-11T21:06:36.051248Z","caller":"traceutil/trace.go:171","msg":"trace[1879648106] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4556; }","duration":"109.377401ms","start":"2026-05-11T21:06:35.941863Z","end":"2026-05-11T21:06:36.051241Z","steps":["trace[1879648106] 'agreement among raft nodes before linearized reading' (duration: 108.491153ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:36.484221Z","caller":"traceutil/trace.go:171","msg":"trace[293096691] transaction","detail":"{read_only:false; response_revision:4572; number_of_response:1; }","duration":"132.414699ms","start":"2026-05-11T21:06:36.351782Z","end":"2026-05-11T21:06:36.484197Z","steps":["trace[293096691] 'process raft request' (duration: 114.112145ms)","trace[293096691] 'compare' (duration: 18.199342ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:06:36.518421Z","caller":"traceutil/trace.go:171","msg":"trace[219858970] linearizableReadLoop","detail":"{readStateIndex:4751; appliedIndex:4749; }","duration":"162.969854ms","start":"2026-05-11T21:06:36.35534Z","end":"2026-05-11T21:06:36.51831Z","steps":["trace[219858970] 'read index received' (duration: 110.566552ms)","trace[219858970] 'applied index is now lower than readState.Index' (duration: 52.401952ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:06:36.51843Z","caller":"traceutil/trace.go:171","msg":"trace[934280765] transaction","detail":"{read_only:false; response_revision:4573; number_of_response:1; }","duration":"165.2129ms","start":"2026-05-11T21:06:36.35319Z","end":"2026-05-11T21:06:36.518403Z","steps":["trace[934280765] 'process raft request' (duration: 164.987395ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:36.518527Z","caller":"traceutil/trace.go:171","msg":"trace[1822173226] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4573; }","duration":"162.114177ms","start":"2026-05-11T21:06:36.356402Z","end":"2026-05-11T21:06:36.518516Z","steps":["trace[1822173226] 'process raft request' (duration: 161.868882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:36.518893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.529265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-05-11T21:06:36.518965Z","caller":"traceutil/trace.go:171","msg":"trace[654969883] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4573; }","duration":"163.614137ms","start":"2026-05-11T21:06:36.355336Z","end":"2026-05-11T21:06:36.51895Z","steps":["trace[654969883] 'agreement among raft nodes before linearized reading' (duration: 163.435464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:36.518964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.247063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-05-11T21:06:36.519023Z","caller":"traceutil/trace.go:171","msg":"trace[428019192] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4573; }","duration":"149.321105ms","start":"2026-05-11T21:06:36.369683Z","end":"2026-05-11T21:06:36.519004Z","steps":["trace[428019192] 'agreement among raft nodes before linearized reading' (duration: 148.921487ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:36.963484Z","caller":"traceutil/trace.go:171","msg":"trace[1344416488] linearizableReadLoop","detail":"{readStateIndex:4761; appliedIndex:4760; }","duration":"281.767255ms","start":"2026-05-11T21:06:36.681699Z","end":"2026-05-11T21:06:36.963466Z","steps":["trace[1344416488] 'read index received' (duration: 260.050551ms)","trace[1344416488] 'applied index is now lower than readState.Index' (duration: 21.715924ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:06:36.963765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.645341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60309"} {"level":"info","ts":"2026-05-11T21:06:36.963794Z","caller":"traceutil/trace.go:171","msg":"trace[1873801793] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4582; }","duration":"299.696522ms","start":"2026-05-11T21:06:36.66409Z","end":"2026-05-11T21:06:36.963787Z","steps":["trace[1873801793] 'agreement among raft nodes before linearized reading' (duration: 299.469617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:36.964088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.141703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"warn","ts":"2026-05-11T21:06:36.964127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.933234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4849"} {"level":"info","ts":"2026-05-11T21:06:36.96421Z","caller":"traceutil/trace.go:171","msg":"trace[1144985276] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4582; }","duration":"272.048796ms","start":"2026-05-11T21:06:36.692143Z","end":"2026-05-11T21:06:36.964192Z","steps":["trace[1144985276] 'agreement among raft nodes before linearized reading' (duration: 271.795021ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:36.964212Z","caller":"traceutil/trace.go:171","msg":"trace[1872538868] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4582; }","duration":"305.251336ms","start":"2026-05-11T21:06:36.65892Z","end":"2026-05-11T21:06:36.964171Z","steps":["trace[1872538868] 'agreement among raft nodes before linearized reading' (duration: 305.039181ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:36.96408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.226522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T21:06:36.964088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.725695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-05-11T21:06:36.964789Z","caller":"traceutil/trace.go:171","msg":"trace[870149556] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4582; }","duration":"306.45884ms","start":"2026-05-11T21:06:36.658312Z","end":"2026-05-11T21:06:36.964771Z","steps":["trace[870149556] 'agreement among raft nodes before linearized reading' (duration: 305.632103ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:36.96481Z","caller":"traceutil/trace.go:171","msg":"trace[555188178] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4582; }","duration":"104.864045ms","start":"2026-05-11T21:06:36.859785Z","end":"2026-05-11T21:06:36.964649Z","steps":["trace[555188178] 'agreement among raft nodes before linearized reading' (duration: 104.211842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:36.96485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:36.658297Z","time spent":"306.538832ms","remote":"127.0.0.1:34988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":2665,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" "} {"level":"info","ts":"2026-05-11T21:06:36.963758Z","caller":"traceutil/trace.go:171","msg":"trace[1815902828] transaction","detail":"{read_only:false; response_revision:4582; number_of_response:1; }","duration":"299.702022ms","start":"2026-05-11T21:06:36.663931Z","end":"2026-05-11T21:06:36.963633Z","steps":["trace[1815902828] 'process raft request' (duration: 277.820694ms)","trace[1815902828] 'compare' (duration: 21.462039ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:06:36.965272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:36.663916Z","time spent":"301.172482ms","remote":"127.0.0.1:48630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2169,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:06:36.96872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:36.658899Z","time spent":"305.725055ms","remote":"127.0.0.1:35250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1146,"request content":"key:\"/registry/storageclasses/general\" "} {"level":"info","ts":"2026-05-11T21:06:37.946903Z","caller":"traceutil/trace.go:171","msg":"trace[1257811442] transaction","detail":"{read_only:false; response_revision:4586; number_of_response:1; }","duration":"325.788957ms","start":"2026-05-11T21:06:37.621084Z","end":"2026-05-11T21:06:37.946873Z","steps":["trace[1257811442] 'process raft request' (duration: 325.628734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:37.947067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:37.621066Z","time spent":"325.91284ms","remote":"127.0.0.1:34960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T21:06:37.958876Z","caller":"traceutil/trace.go:171","msg":"trace[1251760723] linearizableReadLoop","detail":"{readStateIndex:4766; appliedIndex:4764; }","duration":"147.908827ms","start":"2026-05-11T21:06:37.810947Z","end":"2026-05-11T21:06:37.958856Z","steps":["trace[1251760723] 'read index received' (duration: 135.901192ms)","trace[1251760723] 'applied index is now lower than readState.Index' (duration: 12.006795ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:06:37.958988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.01569ms","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-11T21:06:37.959018Z","caller":"traceutil/trace.go:171","msg":"trace[1021539422] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:4587; }","duration":"148.103241ms","start":"2026-05-11T21:06:37.810906Z","end":"2026-05-11T21:06:37.959009Z","steps":["trace[1021539422] 'agreement among raft nodes before linearized reading' (duration: 148.02604ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:37.959004Z","caller":"traceutil/trace.go:171","msg":"trace[1309383443] transaction","detail":"{read_only:false; response_revision:4587; number_of_response:1; }","duration":"333.368731ms","start":"2026-05-11T21:06:37.6256Z","end":"2026-05-11T21:06:37.958968Z","steps":["trace[1309383443] 'process raft request' (duration: 333.150937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:37.959163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:37.625582Z","time spent":"333.498284ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9856,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T21:06:42.721472Z","caller":"traceutil/trace.go:171","msg":"trace[1962242895] linearizableReadLoop","detail":"{readStateIndex:4858; appliedIndex:4857; }","duration":"139.272361ms","start":"2026-05-11T21:06:42.582153Z","end":"2026-05-11T21:06:42.721425Z","steps":["trace[1962242895] 'read index received' (duration: 66.210903ms)","trace[1962242895] 'applied index is now lower than readState.Index' (duration: 73.059918ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:06:42.721696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.522956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-11T21:06:42.721738Z","caller":"traceutil/trace.go:171","msg":"trace[1994044739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4678; }","duration":"139.577377ms","start":"2026-05-11T21:06:42.582148Z","end":"2026-05-11T21:06:42.721726Z","steps":["trace[1994044739] 'agreement among raft nodes before linearized reading' (duration: 139.399904ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:42.721668Z","caller":"traceutil/trace.go:171","msg":"trace[265780013] transaction","detail":"{read_only:false; response_revision:4678; number_of_response:1; }","duration":"139.597157ms","start":"2026-05-11T21:06:42.581883Z","end":"2026-05-11T21:06:42.72148Z","steps":["trace[265780013] 'process raft request' (duration: 66.537239ms)","trace[265780013] 'compare' (duration: 72.669161ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:06:42.870081Z","caller":"traceutil/trace.go:171","msg":"trace[1628786458] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"128.443814ms","start":"2026-05-11T21:06:42.741617Z","end":"2026-05-11T21:06:42.870061Z","steps":["trace[1628786458] 'process raft request' (duration: 94.618993ms)","trace[1628786458] 'compare' (duration: 33.626957ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:06:42.889327Z","caller":"traceutil/trace.go:171","msg":"trace[1561966374] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"140.384884ms","start":"2026-05-11T21:06:42.748917Z","end":"2026-05-11T21:06:42.889302Z","steps":["trace[1561966374] 'process raft request' (duration: 140.140519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:43.632945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.795518ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T21:06:43.633176Z","caller":"traceutil/trace.go:171","msg":"trace[1084143126] linearizableReadLoop","detail":"{readStateIndex:4864; appliedIndex:4862; }","duration":"534.731028ms","start":"2026-05-11T21:06:43.098422Z","end":"2026-05-11T21:06:43.633153Z","steps":["trace[1084143126] 'read index received' (duration: 342.659524ms)","trace[1084143126] 'applied index is now lower than readState.Index' (duration: 192.070524ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:06:43.633267Z","caller":"traceutil/trace.go:171","msg":"trace[1703103705] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"738.503453ms","start":"2026-05-11T21:06:42.894751Z","end":"2026-05-11T21:06:43.633255Z","steps":["trace[1703103705] 'process raft request' (duration: 546.316367ms)","trace[1703103705] 'compare' (duration: 191.323348ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:06:43.633329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:42.894613Z","time spent":"738.682755ms","remote":"127.0.0.1:35048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:06:43.633821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.395531ms","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-11T21:06:43.633865Z","caller":"traceutil/trace.go:171","msg":"trace[471872206] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4684; }","duration":"535.472763ms","start":"2026-05-11T21:06:43.098382Z","end":"2026-05-11T21:06:43.633855Z","steps":["trace[471872206] 'agreement among raft nodes before linearized reading' (duration: 535.35035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:43.633895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:43.098361Z","time spent":"535.527114ms","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-11T21:06:43.634039Z","caller":"traceutil/trace.go:171","msg":"trace[1407467415] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"737.155585ms","start":"2026-05-11T21:06:42.896871Z","end":"2026-05-11T21:06:43.634027Z","steps":["trace[1407467415] 'process raft request' (duration: 736.172645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:43.634114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:42.896859Z","time spent":"737.209436ms","remote":"127.0.0.1:35158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1408,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:06:43.633801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.114758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-05-11T21:06:43.634291Z","caller":"traceutil/trace.go:171","msg":"trace[1947286293] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4684; }","duration":"248.627958ms","start":"2026-05-11T21:06:43.385619Z","end":"2026-05-11T21:06:43.634247Z","steps":["trace[1947286293] 'agreement among raft nodes before linearized reading' (duration: 247.977155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:43.634403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.878341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8573dd84-3bea-4273-9143-5dbbea052e34\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-11T21:06:43.63448Z","caller":"traceutil/trace.go:171","msg":"trace[1807776528] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8573dd84-3bea-4273-9143-5dbbea052e34; range_end:; response_count:1; response_revision:4684; }","duration":"212.004424ms","start":"2026-05-11T21:06:43.422459Z","end":"2026-05-11T21:06:43.634463Z","steps":["trace[1807776528] 'agreement among raft nodes before linearized reading' (duration: 211.779049ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:43.947607Z","caller":"traceutil/trace.go:171","msg":"trace[740319169] linearizableReadLoop","detail":"{readStateIndex:4865; appliedIndex:4864; }","duration":"306.945638ms","start":"2026-05-11T21:06:43.640199Z","end":"2026-05-11T21:06:43.947145Z","steps":["trace[740319169] 'read index received' (duration: 238.428274ms)","trace[740319169] 'applied index is now lower than readState.Index' (duration: 68.515854ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:06:43.947693Z","caller":"traceutil/trace.go:171","msg":"trace[246545769] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"308.830446ms","start":"2026-05-11T21:06:43.638809Z","end":"2026-05-11T21:06:43.947639Z","steps":["trace[246545769] 'process raft request' (duration: 239.880383ms)","trace[246545769] 'compare' (duration: 68.28679ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:06:43.947884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:43.638788Z","time spent":"309.001879ms","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:06:43.948021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.914881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8573dd84-3bea-4273-9143-5dbbea052e34\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-05-11T21:06:43.948074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.857756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-05-11T21:06:43.948099Z","caller":"traceutil/trace.go:171","msg":"trace[1876820205] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8573dd84-3bea-4273-9143-5dbbea052e34; range_end:; response_count:1; response_revision:4685; }","duration":"201.000643ms","start":"2026-05-11T21:06:43.747079Z","end":"2026-05-11T21:06:43.94808Z","steps":["trace[1876820205] 'agreement among raft nodes before linearized reading' (duration: 200.800409ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:43.948134Z","caller":"traceutil/trace.go:171","msg":"trace[683360358] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4685; }","duration":"307.933128ms","start":"2026-05-11T21:06:43.640185Z","end":"2026-05-11T21:06:43.948118Z","steps":["trace[683360358] 'agreement among raft nodes before linearized reading' (duration: 307.585931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:43.948343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.078024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6f88c56658-b6nms.18ae9ee37c646411\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-05-11T21:06:43.948456Z","caller":"traceutil/trace.go:171","msg":"trace[226189379] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-6f88c56658-b6nms.18ae9ee37c646411; range_end:; response_count:1; response_revision:4685; }","duration":"201.207777ms","start":"2026-05-11T21:06:43.747198Z","end":"2026-05-11T21:06:43.948406Z","steps":["trace[226189379] 'agreement among raft nodes before linearized reading' (duration: 200.820669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:43.948358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:43.640174Z","time spent":"308.163442ms","remote":"127.0.0.1:34988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1343,"request content":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" "} {"level":"warn","ts":"2026-05-11T21:06:44.616636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.236648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-05-11T21:06:44.616721Z","caller":"traceutil/trace.go:171","msg":"trace[1238496082] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4694; }","duration":"429.390051ms","start":"2026-05-11T21:06:44.187311Z","end":"2026-05-11T21:06:44.616701Z","steps":["trace[1238496082] 'range keys from in-memory index tree' (duration: 429.036284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:44.616761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:44.187281Z","time spent":"429.471483ms","remote":"127.0.0.1:35330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":9661,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "} {"level":"info","ts":"2026-05-11T21:06:44.652714Z","caller":"traceutil/trace.go:171","msg":"trace[1731700860] linearizableReadLoop","detail":"{readStateIndex:4876; appliedIndex:4875; }","duration":"345.726127ms","start":"2026-05-11T21:06:44.306954Z","end":"2026-05-11T21:06:44.65268Z","steps":["trace[1731700860] 'read index received' (duration: 345.521853ms)","trace[1731700860] 'applied index is now lower than readState.Index' (duration: 203.224µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:06:44.652897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.923651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T21:06:44.652841Z","caller":"traceutil/trace.go:171","msg":"trace[858621511] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"378.34727ms","start":"2026-05-11T21:06:44.274464Z","end":"2026-05-11T21:06:44.652811Z","steps":["trace[858621511] 'process raft request' (duration: 377.976932ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:44.652969Z","caller":"traceutil/trace.go:171","msg":"trace[397086317] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:4695; }","duration":"346.044823ms","start":"2026-05-11T21:06:44.306906Z","end":"2026-05-11T21:06:44.652951Z","steps":["trace[397086317] 'agreement among raft nodes before linearized reading' (duration: 345.912471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:44.653014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:44.306884Z","time spent":"346.120635ms","remote":"127.0.0.1:41612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true "} {"level":"warn","ts":"2026-05-11T21:06:44.653082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:44.274439Z","time spent":"378.552024ms","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:06:44.653403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.781408ms","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-11T21:06:44.653535Z","caller":"traceutil/trace.go:171","msg":"trace[1419338237] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4695; }","duration":"300.012993ms","start":"2026-05-11T21:06:44.353508Z","end":"2026-05-11T21:06:44.653521Z","steps":["trace[1419338237] 'agreement among raft nodes before linearized reading' (duration: 299.630705ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:44.653647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:44.353481Z","time spent":"300.142815ms","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-11T21:06:44.787936Z","caller":"traceutil/trace.go:171","msg":"trace[2107430537] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"130.151983ms","start":"2026-05-11T21:06:44.657761Z","end":"2026-05-11T21:06:44.787913Z","steps":["trace[2107430537] 'process raft request' (duration: 64.713794ms)","trace[2107430537] 'compare' (duration: 65.271136ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:06:44.788253Z","caller":"traceutil/trace.go:171","msg":"trace[2038505842] transaction","detail":"{read_only:false; response_revision:4698; number_of_response:1; }","duration":"129.9753ms","start":"2026-05-11T21:06:44.658269Z","end":"2026-05-11T21:06:44.788244Z","steps":["trace[2038505842] 'process raft request' (duration: 129.610633ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:06:46.157232Z","caller":"traceutil/trace.go:171","msg":"trace[752179968] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"127.681981ms","start":"2026-05-11T21:06:46.029525Z","end":"2026-05-11T21:06:46.157207Z","steps":["trace[752179968] 'process raft request' (duration: 50.439774ms)","trace[752179968] 'compare' (duration: 77.089934ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:06:54.098882Z","caller":"traceutil/trace.go:171","msg":"trace[1362331250] linearizableReadLoop","detail":"{readStateIndex:5011; appliedIndex:5010; }","duration":"228.143441ms","start":"2026-05-11T21:06:53.870717Z","end":"2026-05-11T21:06:54.09886Z","steps":["trace[1362331250] 'read index received' (duration: 227.945467ms)","trace[1362331250] 'applied index is now lower than readState.Index' (duration: 197.364µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:06:54.099012Z","caller":"traceutil/trace.go:171","msg":"trace[1023633434] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"238.102506ms","start":"2026-05-11T21:06:53.860806Z","end":"2026-05-11T21:06:54.098909Z","steps":["trace[1023633434] 'process raft request' (duration: 237.941322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:54.099119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.956008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-11T21:06:54.099157Z","caller":"traceutil/trace.go:171","msg":"trace[977972286] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4825; }","duration":"162.008159ms","start":"2026-05-11T21:06:53.937136Z","end":"2026-05-11T21:06:54.099144Z","steps":["trace[977972286] 'agreement among raft nodes before linearized reading' (duration: 161.857546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:54.099154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.421346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-11T21:06:54.09921Z","caller":"traceutil/trace.go:171","msg":"trace[1915071144] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:4825; }","duration":"228.506538ms","start":"2026-05-11T21:06:53.870688Z","end":"2026-05-11T21:06:54.099195Z","steps":["trace[1915071144] 'agreement among raft nodes before linearized reading' (duration: 228.303204ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:54.099622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.173549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-11T21:06:54.099717Z","caller":"traceutil/trace.go:171","msg":"trace[458116570] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4825; }","duration":"105.282812ms","start":"2026-05-11T21:06:53.994399Z","end":"2026-05-11T21:06:54.099681Z","steps":["trace[458116570] 'agreement among raft nodes before linearized reading' (duration: 104.957735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:59.432853Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938291424478179263,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-11T21:06:59.900864Z","caller":"traceutil/trace.go:171","msg":"trace[263726166] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"988.996334ms","start":"2026-05-11T21:06:58.91185Z","end":"2026-05-11T21:06:59.900847Z","steps":["trace[263726166] 'process raft request' (duration: 988.862651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:06:59.901099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:58.911823Z","time spent":"989.096275ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17216,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:07:00.110687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.347498ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-11T21:07:00.110793Z","caller":"traceutil/trace.go:171","msg":"trace[1810614248] linearizableReadLoop","detail":"{readStateIndex:5073; appliedIndex:5071; }","duration":"1.17845298s","start":"2026-05-11T21:06:58.932322Z","end":"2026-05-11T21:07:00.110775Z","steps":["trace[1810614248] 'read index received' (duration: 968.411576ms)","trace[1810614248] 'applied index is now lower than readState.Index' (duration: 210.040004ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:07:00.11121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.178872828s","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-11T21:07:00.111274Z","caller":"traceutil/trace.go:171","msg":"trace[1668846863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4885; }","duration":"1.17898059s","start":"2026-05-11T21:06:58.932278Z","end":"2026-05-11T21:07:00.111259Z","steps":["trace[1668846863] 'agreement among raft nodes before linearized reading' (duration: 1.178798027s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:00.111274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.178903339s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-11T21:07:00.11131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:58.932257Z","time spent":"1.179045691s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-11T21:07:00.11133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.9522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T21:07:00.111359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.608302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17231"} {"level":"info","ts":"2026-05-11T21:07:00.111314Z","caller":"traceutil/trace.go:171","msg":"trace[1795016945] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4885; }","duration":"1.17897217s","start":"2026-05-11T21:06:58.932331Z","end":"2026-05-11T21:07:00.111303Z","steps":["trace[1795016945] 'agreement among raft nodes before linearized reading' (duration: 1.178794307s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:00.111319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.17118769s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-11T21:07:00.11144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.440501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-05-11T21:07:00.111514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:58.932321Z","time spent":"1.179179334s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-11T21:07:00.111527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.130847202s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-11T21:07:00.111527Z","caller":"traceutil/trace.go:171","msg":"trace[287028144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4885; }","duration":"1.171418725s","start":"2026-05-11T21:06:58.940087Z","end":"2026-05-11T21:07:00.111506Z","steps":["trace[287028144] 'agreement among raft nodes before linearized reading' (duration: 1.171113699s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:00.111767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:58.940073Z","time spent":"1.17167266s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-11T21:07:00.111468Z","caller":"traceutil/trace.go:171","msg":"trace[1509526121] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4885; }","duration":"200.741695ms","start":"2026-05-11T21:06:59.910707Z","end":"2026-05-11T21:07:00.111449Z","steps":["trace[1509526121] 'agreement among raft nodes before linearized reading' (duration: 200.49211ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:07:00.11156Z","caller":"traceutil/trace.go:171","msg":"trace[192106974] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4885; }","duration":"1.130913314s","start":"2026-05-11T21:06:58.980636Z","end":"2026-05-11T21:07:00.11155Z","steps":["trace[192106974] 'agreement among raft nodes before linearized reading' (duration: 1.130830922s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:00.111945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:58.980616Z","time spent":"1.131314841s","remote":"127.0.0.1:35034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-05-11T21:07:00.111405Z","caller":"traceutil/trace.go:171","msg":"trace[443111529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4885; }","duration":"251.059093ms","start":"2026-05-11T21:06:59.860325Z","end":"2026-05-11T21:07:00.111384Z","steps":["trace[443111529] 'agreement among raft nodes before linearized reading' (duration: 250.92374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:00.111517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.178397009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-11T21:07:00.11219Z","caller":"traceutil/trace.go:171","msg":"trace[1017377000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4885; }","duration":"1.179070302s","start":"2026-05-11T21:06:58.933101Z","end":"2026-05-11T21:07:00.112171Z","steps":["trace[1017377000] 'agreement among raft nodes before linearized reading' (duration: 1.178245796s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:00.112255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:58.933079Z","time spent":"1.179158644s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-11T21:07:00.111601Z","caller":"traceutil/trace.go:171","msg":"trace[1883682294] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4885; }","duration":"484.628133ms","start":"2026-05-11T21:06:59.626902Z","end":"2026-05-11T21:07:00.11153Z","steps":["trace[1883682294] 'agreement among raft nodes before linearized reading' (duration: 484.295607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:00.112436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:06:59.626883Z","time spent":"485.489941ms","remote":"127.0.0.1:55180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3338,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-05-11T21:07:01.406504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.148997799s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T21:07:01.407459Z","caller":"traceutil/trace.go:171","msg":"trace[305819526] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"1.290291379s","start":"2026-05-11T21:07:00.117138Z","end":"2026-05-11T21:07:01.407429Z","steps":["trace[305819526] 'process raft request' (duration: 140.278811ms)","trace[305819526] 'compare' (duration: 1.148827866s)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:07:01.407523Z","caller":"traceutil/trace.go:171","msg":"trace[228771521] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"1.289370642s","start":"2026-05-11T21:07:00.118132Z","end":"2026-05-11T21:07:01.407503Z","steps":["trace[228771521] 'process raft request' (duration: 1.289173828s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:01.407616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.117125Z","time spent":"1.290413181s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T21:07:01.407748Z","caller":"traceutil/trace.go:171","msg":"trace[1641439396] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"1.288516315s","start":"2026-05-11T21:07:00.119159Z","end":"2026-05-11T21:07:01.407676Z","steps":["trace[1641439396] 'process raft request' (duration: 1.288282571s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:01.407769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.118117Z","time spent":"1.289479924s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:07:01.407884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.119149Z","time spent":"1.288679368s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T21:07:01.408202Z","caller":"traceutil/trace.go:171","msg":"trace[2022910605] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"1.284123721s","start":"2026-05-11T21:07:00.124047Z","end":"2026-05-11T21:07:01.40817Z","steps":["trace[2022910605] 'process raft request' (duration: 1.283434647s)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:07:01.408346Z","caller":"traceutil/trace.go:171","msg":"trace[634274700] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"1.201602598s","start":"2026-05-11T21:07:00.206727Z","end":"2026-05-11T21:07:01.40833Z","steps":["trace[634274700] 'process raft request' (duration: 1.201561707s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:01.408428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.206706Z","time spent":"1.20168327s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:07:01.408576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.124038Z","time spent":"1.284302375s","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17190,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T21:07:01.408239Z","caller":"traceutil/trace.go:171","msg":"trace[1806785574] linearizableReadLoop","detail":"{readStateIndex:5076; appliedIndex:5073; }","duration":"1.289726969s","start":"2026-05-11T21:07:00.118499Z","end":"2026-05-11T21:07:01.408226Z","steps":["trace[1806785574] 'read index received' (duration: 33.739707ms)","trace[1806785574] 'applied index is now lower than readState.Index' (duration: 1.255986122s)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:07:01.408626Z","caller":"traceutil/trace.go:171","msg":"trace[1586039624] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"1.205296899s","start":"2026-05-11T21:07:00.203318Z","end":"2026-05-11T21:07:01.408615Z","steps":["trace[1586039624] 'process raft request' (duration: 1.204894901s)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:07:01.408659Z","caller":"traceutil/trace.go:171","msg":"trace[118277115] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"1.207481731s","start":"2026-05-11T21:07:00.201169Z","end":"2026-05-11T21:07:01.408651Z","steps":["trace[118277115] 'process raft request' (duration: 1.206975211s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:01.409181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.201137Z","time spent":"1.207991051s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:07:01.409207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.20329Z","time spent":"1.205789518s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:07:01.409375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.185994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-05-11T21:07:01.409366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.793794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T21:07:01.409436Z","caller":"traceutil/trace.go:171","msg":"trace[1654939236] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4894; }","duration":"358.271554ms","start":"2026-05-11T21:07:01.051144Z","end":"2026-05-11T21:07:01.409415Z","steps":["trace[1654939236] 'agreement among raft nodes before linearized reading' (duration: 358.154532ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:07:01.409443Z","caller":"traceutil/trace.go:171","msg":"trace[1678355320] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:4894; }","duration":"140.931767ms","start":"2026-05-11T21:07:01.268493Z","end":"2026-05-11T21:07:01.409425Z","steps":["trace[1678355320] 'agreement among raft nodes before linearized reading' (duration: 140.760003ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:01.409493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:01.051125Z","time spent":"358.359097ms","remote":"127.0.0.1:55180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3338,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-05-11T21:07:01.409552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290179977s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-05-11T21:07:01.409583Z","caller":"traceutil/trace.go:171","msg":"trace[368692534] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4894; }","duration":"1.290222328s","start":"2026-05-11T21:07:00.119352Z","end":"2026-05-11T21:07:01.409574Z","steps":["trace[368692534] 'agreement among raft nodes before linearized reading' (duration: 1.289801269s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:01.409609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.119343Z","time spent":"1.290259739s","remote":"127.0.0.1:34988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1343,"request content":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" "} {"level":"warn","ts":"2026-05-11T21:07:01.409346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290820499s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"warn","ts":"2026-05-11T21:07:01.409805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.141865203s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-11T21:07:01.409823Z","caller":"traceutil/trace.go:171","msg":"trace[1785834979] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4894; }","duration":"1.29134574s","start":"2026-05-11T21:07:00.118463Z","end":"2026-05-11T21:07:01.409809Z","steps":["trace[1785834979] 'agreement among raft nodes before linearized reading' (duration: 1.28980048s)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:07:01.409837Z","caller":"traceutil/trace.go:171","msg":"trace[968961422] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:4894; }","duration":"1.141933013s","start":"2026-05-11T21:07:00.267894Z","end":"2026-05-11T21:07:01.409827Z","steps":["trace[968961422] 'agreement among raft nodes before linearized reading' (duration: 1.141849662s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:01.409854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.118455Z","time spent":"1.291389581s","remote":"127.0.0.1:35034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2104,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-05-11T21:07:01.409868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.267878Z","time spent":"1.141982365s","remote":"127.0.0.1:35242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":72,"response size":29,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-05-11T21:07:01.408683Z","caller":"traceutil/trace.go:171","msg":"trace[162995915] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"1.204784029s","start":"2026-05-11T21:07:00.203874Z","end":"2026-05-11T21:07:01.408658Z","steps":["trace[162995915] 'process raft request' (duration: 1.204371951s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:01.409965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.20386Z","time spent":"1.206042273s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T21:07:01.409271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.600465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T21:07:01.410054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.281343738s","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-11T21:07:01.410075Z","caller":"traceutil/trace.go:171","msg":"trace[1511960491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4894; }","duration":"437.438102ms","start":"2026-05-11T21:07:00.972622Z","end":"2026-05-11T21:07:01.41006Z","steps":["trace[1511960491] 'agreement among raft nodes before linearized reading' (duration: 436.612396ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:01.410181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.972604Z","time spent":"437.564644ms","remote":"127.0.0.1:34876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-11T21:07:01.410117Z","caller":"traceutil/trace.go:171","msg":"trace[638673877] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4894; }","duration":"1.28142362s","start":"2026-05-11T21:07:00.128681Z","end":"2026-05-11T21:07:01.410105Z","steps":["trace[638673877] 'agreement among raft nodes before linearized reading' (duration: 1.281282477s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:01.410282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T21:07:00.128675Z","time spent":"1.281594643s","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-11T21:07:33.846143Z","caller":"traceutil/trace.go:171","msg":"trace[2090076969] linearizableReadLoop","detail":"{readStateIndex:5379; appliedIndex:5378; }","duration":"103.034391ms","start":"2026-05-11T21:07:33.743079Z","end":"2026-05-11T21:07:33.846114Z","steps":["trace[2090076969] 'read index received' (duration: 684.742µs)","trace[2090076969] 'applied index is now lower than readState.Index' (duration: 102.348419ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:07:33.846203Z","caller":"traceutil/trace.go:171","msg":"trace[1431512967] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"106.508363ms","start":"2026-05-11T21:07:33.739649Z","end":"2026-05-11T21:07:33.846157Z","steps":["trace[1431512967] 'process raft request' (duration: 37.309873ms)","trace[1431512967] 'compare' (duration: 68.906075ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:07:33.84651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.273415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-11T21:07:33.846557Z","caller":"traceutil/trace.go:171","msg":"trace[1826435571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5183; }","duration":"103.422839ms","start":"2026-05-11T21:07:33.74312Z","end":"2026-05-11T21:07:33.846542Z","steps":["trace[1826435571] 'agreement among raft nodes before linearized reading' (duration: 103.169694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:33.846652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.417178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-11T21:07:33.846671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.48098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-11T21:07:33.846836Z","caller":"traceutil/trace.go:171","msg":"trace[440962234] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5183; }","duration":"103.661082ms","start":"2026-05-11T21:07:33.743147Z","end":"2026-05-11T21:07:33.846808Z","steps":["trace[440962234] 'agreement among raft nodes before linearized reading' (duration: 103.181444ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:07:33.846893Z","caller":"traceutil/trace.go:171","msg":"trace[828718301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5183; }","duration":"103.937228ms","start":"2026-05-11T21:07:33.742885Z","end":"2026-05-11T21:07:33.846822Z","steps":["trace[828718301] 'agreement among raft nodes before linearized reading' (duration: 103.458099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:35.980826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.529708ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T21:07:35.981115Z","caller":"traceutil/trace.go:171","msg":"trace[999894446] linearizableReadLoop","detail":"{readStateIndex:5390; appliedIndex:5387; }","duration":"130.559521ms","start":"2026-05-11T21:07:35.850537Z","end":"2026-05-11T21:07:35.981097Z","steps":["trace[999894446] 'read index received' (duration: 7.700627ms)","trace[999894446] 'applied index is now lower than readState.Index' (duration: 122.857854ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:07:35.981211Z","caller":"traceutil/trace.go:171","msg":"trace[199099153] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"286.195646ms","start":"2026-05-11T21:07:35.695003Z","end":"2026-05-11T21:07:35.981198Z","steps":["trace[199099153] 'process raft request' (duration: 163.201369ms)","trace[199099153] 'compare' (duration: 122.109421ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:07:35.981328Z","caller":"traceutil/trace.go:171","msg":"trace[299544803] transaction","detail":"{read_only:false; response_revision:5193; number_of_response:1; }","duration":"233.645985ms","start":"2026-05-11T21:07:35.747641Z","end":"2026-05-11T21:07:35.981287Z","steps":["trace[299544803] 'process raft request' (duration: 233.413321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:35.981577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.041329ms","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-11T21:07:35.981619Z","caller":"traceutil/trace.go:171","msg":"trace[282667600] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5193; }","duration":"131.122921ms","start":"2026-05-11T21:07:35.850486Z","end":"2026-05-11T21:07:35.981609Z","steps":["trace[282667600] 'agreement among raft nodes before linearized reading' (duration: 130.939328ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:07:35.981635Z","caller":"traceutil/trace.go:171","msg":"trace[1772207739] transaction","detail":"{read_only:false; response_revision:5192; number_of_response:1; }","duration":"240.280863ms","start":"2026-05-11T21:07:35.741341Z","end":"2026-05-11T21:07:35.981622Z","steps":["trace[1772207739] 'process raft request' (duration: 239.609982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:35.981704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.336155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T21:07:35.981781Z","caller":"traceutil/trace.go:171","msg":"trace[993608428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5193; }","duration":"122.463848ms","start":"2026-05-11T21:07:35.8593Z","end":"2026-05-11T21:07:35.981764Z","steps":["trace[993608428] 'agreement among raft nodes before linearized reading' (duration: 122.314985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:35.981785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.116672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-11T21:07:35.981815Z","caller":"traceutil/trace.go:171","msg":"trace[619939413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5193; }","duration":"100.213714ms","start":"2026-05-11T21:07:35.881594Z","end":"2026-05-11T21:07:35.981808Z","steps":["trace[619939413] 'agreement among raft nodes before linearized reading' (duration: 100.130582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:07:35.981814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.741853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-11T21:07:35.981879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.574208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-11T21:07:35.981896Z","caller":"traceutil/trace.go:171","msg":"trace[206187199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5193; }","duration":"100.854705ms","start":"2026-05-11T21:07:35.881023Z","end":"2026-05-11T21:07:35.981878Z","steps":["trace[206187199] 'agreement among raft nodes before linearized reading' (duration: 100.59997ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:07:35.981928Z","caller":"traceutil/trace.go:171","msg":"trace[392757290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5193; }","duration":"101.66919ms","start":"2026-05-11T21:07:35.880247Z","end":"2026-05-11T21:07:35.981916Z","steps":["trace[392757290] 'agreement among raft nodes before linearized reading' (duration: 101.473666ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:08:09.780368Z","caller":"traceutil/trace.go:171","msg":"trace[1398602521] transaction","detail":"{read_only:false; response_revision:5439; number_of_response:1; }","duration":"194.55999ms","start":"2026-05-11T21:08:09.585774Z","end":"2026-05-11T21:08:09.780334Z","steps":["trace[1398602521] 'process raft request' (duration: 129.736693ms)","trace[1398602521] 'compare' (duration: 64.497061ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:08:41.091829Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2959} {"level":"info","ts":"2026-05-11T21:08:41.181408Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2959,"took":"88.56907ms","hash":3395088217,"current-db-size-bytes":53399552,"current-db-size":"53 MB","current-db-size-in-use-bytes":29437952,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-11T21:08:41.18148Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3395088217,"revision":2959,"compact-revision":-1} {"level":"warn","ts":"2026-05-11T21:10:30.967334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.044791ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T21:10:30.967559Z","caller":"traceutil/trace.go:171","msg":"trace[1773837969] transaction","detail":"{read_only:false; response_revision:6424; number_of_response:1; }","duration":"234.518099ms","start":"2026-05-11T21:10:30.733008Z","end":"2026-05-11T21:10:30.967526Z","steps":["trace[1773837969] 'process raft request' (duration: 60.193074ms)","trace[1773837969] 'compare' (duration: 173.867788ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:10:30.967656Z","caller":"traceutil/trace.go:171","msg":"trace[437027366] transaction","detail":"{read_only:false; response_revision:6425; number_of_response:1; }","duration":"234.436248ms","start":"2026-05-11T21:10:30.733208Z","end":"2026-05-11T21:10:30.967644Z","steps":["trace[437027366] 'process raft request' (duration: 234.233506ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:10:30.967561Z","caller":"traceutil/trace.go:171","msg":"trace[1200764594] linearizableReadLoop","detail":"{readStateIndex:6664; appliedIndex:6662; }","duration":"106.990759ms","start":"2026-05-11T21:10:30.86055Z","end":"2026-05-11T21:10:30.967541Z","steps":["trace[1200764594] 'read index received' (duration: 48.42µs)","trace[1200764594] 'applied index is now lower than readState.Index' (duration: 106.941159ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:10:30.968053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.256923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T21:10:30.968111Z","caller":"traceutil/trace.go:171","msg":"trace[614900634] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6425; }","duration":"107.589768ms","start":"2026-05-11T21:10:30.860505Z","end":"2026-05-11T21:10:30.968095Z","steps":["trace[614900634] 'agreement among raft nodes before linearized reading' (duration: 107.189912ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:10:43.212354Z","caller":"traceutil/trace.go:171","msg":"trace[417720226] linearizableReadLoop","detail":"{readStateIndex:6733; appliedIndex:6732; }","duration":"141.239048ms","start":"2026-05-11T21:10:43.071092Z","end":"2026-05-11T21:10:43.212331Z","steps":["trace[417720226] 'read index received' (duration: 60.690684ms)","trace[417720226] 'applied index is now lower than readState.Index' (duration: 80.547334ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:10:43.212446Z","caller":"traceutil/trace.go:171","msg":"trace[1356239165] transaction","detail":"{read_only:false; response_revision:6492; number_of_response:1; }","duration":"147.374335ms","start":"2026-05-11T21:10:43.065035Z","end":"2026-05-11T21:10:43.212409Z","steps":["trace[1356239165] 'process raft request' (duration: 121.922846ms)","trace[1356239165] 'compare' (duration: 25.273206ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:10:43.212564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.710018ms","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-11T21:10:43.212598Z","caller":"traceutil/trace.go:171","msg":"trace[1707735247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6492; }","duration":"132.767709ms","start":"2026-05-11T21:10:43.07982Z","end":"2026-05-11T21:10:43.212587Z","steps":["trace[1707735247] 'agreement among raft nodes before linearized reading' (duration: 132.635247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:10:43.212585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.467422ms","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-11T21:10:43.212657Z","caller":"traceutil/trace.go:171","msg":"trace[1620248634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6492; }","duration":"141.578124ms","start":"2026-05-11T21:10:43.07106Z","end":"2026-05-11T21:10:43.212638Z","steps":["trace[1620248634] 'agreement among raft nodes before linearized reading' (duration: 141.355031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:10:43.212641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.246564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-11T21:10:43.212704Z","caller":"traceutil/trace.go:171","msg":"trace[1092754474] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6492; }","duration":"130.334425ms","start":"2026-05-11T21:10:43.082354Z","end":"2026-05-11T21:10:43.212688Z","steps":["trace[1092754474] 'agreement among raft nodes before linearized reading' (duration: 130.163552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:10:43.212736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.817252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T21:10:43.212762Z","caller":"traceutil/trace.go:171","msg":"trace[1592045943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6492; }","duration":"130.863852ms","start":"2026-05-11T21:10:43.08189Z","end":"2026-05-11T21:10:43.212754Z","steps":["trace[1592045943] 'agreement among raft nodes before linearized reading' (duration: 130.783331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:11:03.550657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.440139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-05-11T21:11:03.551464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.15979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/users.rabbitmq.com\" ","response":"range_response_count:1 size:8268"} {"level":"info","ts":"2026-05-11T21:11:03.551584Z","caller":"traceutil/trace.go:171","msg":"trace[648827285] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/users.rabbitmq.com; range_end:; response_count:1; response_revision:6648; }","duration":"211.277872ms","start":"2026-05-11T21:11:03.340251Z","end":"2026-05-11T21:11:03.551529Z","steps":["trace[648827285] 'agreement among raft nodes before linearized reading' (duration: 211.026428ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:11:03.551775Z","caller":"traceutil/trace.go:171","msg":"trace[1875485004] transaction","detail":"{read_only:false; response_revision:6648; number_of_response:1; }","duration":"219.090901ms","start":"2026-05-11T21:11:03.331983Z","end":"2026-05-11T21:11:03.551074Z","steps":["trace[1875485004] 'process raft request' (duration: 71.874441ms)","trace[1875485004] 'compare' (duration: 146.327858ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T21:11:03.552297Z","caller":"traceutil/trace.go:171","msg":"trace[1616686098] linearizableReadLoop","detail":"{readStateIndex:6897; appliedIndex:6896; }","duration":"210.706284ms","start":"2026-05-11T21:11:03.340285Z","end":"2026-05-11T21:11:03.550991Z","steps":["trace[1616686098] 'read index received' (duration: 63.529485ms)","trace[1616686098] 'applied index is now lower than readState.Index' (duration: 147.174699ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T21:11:03.552873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.776291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-11T21:11:03.55305Z","caller":"traceutil/trace.go:171","msg":"trace[1443726114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6648; }","duration":"153.977874ms","start":"2026-05-11T21:11:03.399056Z","end":"2026-05-11T21:11:03.553034Z","steps":["trace[1443726114] 'agreement among raft nodes before linearized reading' (duration: 153.713591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:11:03.55376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.274774ms","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-11T21:11:03.553934Z","caller":"traceutil/trace.go:171","msg":"trace[1998341411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6648; }","duration":"158.467827ms","start":"2026-05-11T21:11:03.395454Z","end":"2026-05-11T21:11:03.553921Z","steps":["trace[1998341411] 'agreement among raft nodes before linearized reading' (duration: 158.240224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T21:11:03.554398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.004462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-11T21:11:03.554566Z","caller":"traceutil/trace.go:171","msg":"trace[1546065346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6648; }","duration":"161.204664ms","start":"2026-05-11T21:11:03.393345Z","end":"2026-05-11T21:11:03.55455Z","steps":["trace[1546065346] 'agreement among raft nodes before linearized reading' (duration: 159.368849ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T21:13:41.097101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5671} {"level":"info","ts":"2026-05-11T21:13:41.18885Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5671,"took":"90.2976ms","hash":3951730876,"current-db-size-bytes":53399552,"current-db-size":"53 MB","current-db-size-in-use-bytes":18141184,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-11T21:13:41.188926Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3951730876,"revision":5671,"compact-revision":2959}