{"level":"warn","ts":"2026-06-08T03:34:43.455969Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T03:34:43.456101Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65: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-06-08T03:34:43.45621Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T03:34:43.456232Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-08T03:34:43.456261Z","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-06-08T03:34:43.45758Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-06-08T03:34:43.45769Z","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":16,"max-cpu-available":16,"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.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65: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-06-08T03:34:43.461867Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.90968ms"} {"level":"info","ts":"2026-06-08T03:34:43.472248Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-06-08T03:34:43.472316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-08T03:34:43.472334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-06-08T03:34:43.472347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-08T03:34:43.472357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-06-08T03:34:43.47239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-06-08T03:34:43.47716Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-08T03:34:43.48042Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-08T03:34:43.482818Z","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-06-08T03:34:43.48672Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-08T03:34:43.486881Z","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-06-08T03:34:43.486965Z","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-06-08T03:34:43.486982Z","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-06-08T03:34:43.487077Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-08T03:34:43.487651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-06-08T03:34:43.487754Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-06-08T03:34:43.490525Z","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-06-08T03:34:43.490786Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-08T03:34:43.490829Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-08T03:34:43.490961Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-08T03:34:43.491003Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-06-08T03:34:43.673122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-08T03:34:43.67319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-08T03:34:43.673229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-06-08T03:34:43.673273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-06-08T03:34:43.673291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-08T03:34:43.673316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-06-08T03:34:43.673332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-06-08T03:34:43.674245Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T03:34:43.675096Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-06-08T03:34:43.675277Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T03:34:43.675328Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T03:34:43.675738Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T03:34:43.675735Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-08T03:34:43.675837Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-08T03:34:43.675958Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T03:34:43.67603Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T03:34:43.678787Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-08T03:34:43.678818Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-06-08T03:34:59.754448Z","caller":"traceutil/trace.go:171","msg":"trace[1491914063] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"154.228672ms","start":"2026-06-08T03:34:59.600191Z","end":"2026-06-08T03:34:59.75442Z","steps":["trace[1491914063] 'process raft request' (duration: 107.65404ms)","trace[1491914063] 'compare' (duration: 46.469639ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:35:20.500696Z","caller":"traceutil/trace.go:171","msg":"trace[746765450] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"169.827639ms","start":"2026-06-08T03:35:20.330846Z","end":"2026-06-08T03:35:20.500674Z","steps":["trace[746765450] 'process raft request' (duration: 169.705677ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:20.507691Z","caller":"traceutil/trace.go:171","msg":"trace[1062676903] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"158.464449ms","start":"2026-06-08T03:35:20.349199Z","end":"2026-06-08T03:35:20.507664Z","steps":["trace[1062676903] 'process raft request' (duration: 158.111581ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:20.507779Z","caller":"traceutil/trace.go:171","msg":"trace[1910829935] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"171.710548ms","start":"2026-06-08T03:35:20.336031Z","end":"2026-06-08T03:35:20.507742Z","steps":["trace[1910829935] 'process raft request' (duration: 171.197698ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:20.507844Z","caller":"traceutil/trace.go:171","msg":"trace[1002042472] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"171.845432ms","start":"2026-06-08T03:35:20.335968Z","end":"2026-06-08T03:35:20.507813Z","steps":["trace[1002042472] 'process raft request' (duration: 171.151178ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:20.50792Z","caller":"traceutil/trace.go:171","msg":"trace[2113376877] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"133.417827ms","start":"2026-06-08T03:35:20.374451Z","end":"2026-06-08T03:35:20.507869Z","steps":["trace[2113376877] 'process raft request' (duration: 133.110771ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:20.507889Z","caller":"traceutil/trace.go:171","msg":"trace[1328916987] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"140.740706ms","start":"2026-06-08T03:35:20.367096Z","end":"2026-06-08T03:35:20.507837Z","steps":["trace[1328916987] 'process raft request' (duration: 140.42838ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:20.508046Z","caller":"traceutil/trace.go:171","msg":"trace[627123138] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"128.261711ms","start":"2026-06-08T03:35:20.379772Z","end":"2026-06-08T03:35:20.508034Z","steps":["trace[627123138] 'process raft request' (duration: 127.872893ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:20.507994Z","caller":"traceutil/trace.go:171","msg":"trace[362729802] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"154.425685ms","start":"2026-06-08T03:35:20.353499Z","end":"2026-06-08T03:35:20.507924Z","steps":["trace[362729802] 'process raft request' (duration: 153.861353ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:20.508071Z","caller":"traceutil/trace.go:171","msg":"trace[767455287] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"119.853759ms","start":"2026-06-08T03:35:20.388184Z","end":"2026-06-08T03:35:20.508038Z","steps":["trace[767455287] 'process raft request' (duration: 119.563723ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:20.508084Z","caller":"traceutil/trace.go:171","msg":"trace[1381353048] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"154.452006ms","start":"2026-06-08T03:35:20.35356Z","end":"2026-06-08T03:35:20.508012Z","steps":["trace[1381353048] 'process raft request' (duration: 153.915585ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:20.508214Z","caller":"traceutil/trace.go:171","msg":"trace[629526] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"160.802326ms","start":"2026-06-08T03:35:20.346982Z","end":"2026-06-08T03:35:20.507784Z","steps":["trace[629526] 'process raft request' (duration: 160.288356ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:35:26.531094Z","caller":"traceutil/trace.go:171","msg":"trace[125617781] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"177.84351ms","start":"2026-06-08T03:35:26.353207Z","end":"2026-06-08T03:35:26.531051Z","steps":["trace[125617781] 'process raft request' (duration: 176.300968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:35:26.662454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.045118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ntqfp\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-08T03:35:26.66259Z","caller":"traceutil/trace.go:171","msg":"trace[247942237] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ntqfp; range_end:; response_count:1; response_revision:590; }","duration":"108.233632ms","start":"2026-06-08T03:35:26.554332Z","end":"2026-06-08T03:35:26.662565Z","steps":["trace[247942237] 'range keys from in-memory index tree' (duration: 107.920805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:35:27.166337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.546795ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:35:27.166506Z","caller":"traceutil/trace.go:171","msg":"trace[38066693] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"484.626126ms","start":"2026-06-08T03:35:26.68185Z","end":"2026-06-08T03:35:27.166476Z","steps":["trace[38066693] 'process raft request' (duration: 170.225213ms)","trace[38066693] 'compare' (duration: 313.400041ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:35:27.166598Z","caller":"traceutil/trace.go:171","msg":"trace[1493340761] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"428.400983ms","start":"2026-06-08T03:35:26.738174Z","end":"2026-06-08T03:35:27.166575Z","steps":["trace[1493340761] 'read index received' (duration: 113.914319ms)","trace[1493340761] 'applied index is now lower than readState.Index' (duration: 314.484353ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:35:27.166655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:35:26.681823Z","time spent":"484.758469ms","remote":"127.0.0.1:38348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:35:27.166747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.563366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.65\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-08T03:35:27.166782Z","caller":"traceutil/trace.go:171","msg":"trace[1057610050] range","detail":"{range_begin:/registry/masterleases/199.204.45.65; range_end:; response_count:1; response_revision:592; }","duration":"428.623566ms","start":"2026-06-08T03:35:26.738147Z","end":"2026-06-08T03:35:27.166771Z","steps":["trace[1057610050] 'agreement among raft nodes before linearized reading' (duration: 428.548055ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:35:27.166821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:35:26.738135Z","time spent":"428.678907ms","remote":"127.0.0.1:38194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.65\" "} {"level":"warn","ts":"2026-06-08T03:35:27.168605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.342649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:35:27.168661Z","caller":"traceutil/trace.go:171","msg":"trace[1003599163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"194.447691ms","start":"2026-06-08T03:35:26.974201Z","end":"2026-06-08T03:35:27.168649Z","steps":["trace[1003599163] 'agreement among raft nodes before linearized reading' (duration: 194.351449ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:08.938448Z","caller":"traceutil/trace.go:171","msg":"trace[524920549] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"101.712417ms","start":"2026-06-08T03:36:08.836678Z","end":"2026-06-08T03:36:08.938391Z","steps":["trace[524920549] 'process raft request' (duration: 101.543193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:36:54.642048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.637431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-047d4586-0fb3-4b2d-aad6-536b6363d2e7\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-08T03:36:54.642143Z","caller":"traceutil/trace.go:171","msg":"trace[38517922] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-047d4586-0fb3-4b2d-aad6-536b6363d2e7; range_end:; response_count:1; response_revision:1820; }","duration":"110.794115ms","start":"2026-06-08T03:36:54.531329Z","end":"2026-06-08T03:36:54.642123Z","steps":["trace[38517922] 'range keys from in-memory index tree' (duration: 110.454069ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:55.048105Z","caller":"traceutil/trace.go:171","msg":"trace[2047636634] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"105.869194ms","start":"2026-06-08T03:36:54.942206Z","end":"2026-06-08T03:36:55.048076Z","steps":["trace[2047636634] 'process raft request' (duration: 105.67436ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:36:55.073527Z","caller":"traceutil/trace.go:171","msg":"trace[1509661696] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"113.825177ms","start":"2026-06-08T03:36:54.959679Z","end":"2026-06-08T03:36:55.073505Z","steps":["trace[1509661696] 'process raft request' (duration: 113.698414ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:07.268203Z","caller":"traceutil/trace.go:171","msg":"trace[1086420348] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"104.366462ms","start":"2026-06-08T03:37:07.163808Z","end":"2026-06-08T03:37:07.268174Z","steps":["trace[1086420348] 'process raft request' (duration: 104.160778ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:10.960754Z","caller":"traceutil/trace.go:171","msg":"trace[1600587078] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"134.030662ms","start":"2026-06-08T03:37:10.826696Z","end":"2026-06-08T03:37:10.960727Z","steps":["trace[1600587078] 'process raft request' (duration: 133.871399ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:49.331036Z","caller":"traceutil/trace.go:171","msg":"trace[1896899480] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"114.295777ms","start":"2026-06-08T03:37:49.216712Z","end":"2026-06-08T03:37:49.331008Z","steps":["trace[1896899480] 'process raft request' (duration: 114.145304ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:50.024305Z","caller":"traceutil/trace.go:171","msg":"trace[1111545393] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"111.541841ms","start":"2026-06-08T03:37:49.912729Z","end":"2026-06-08T03:37:50.024271Z","steps":["trace[1111545393] 'process raft request' (duration: 111.338536ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:37:50.213282Z","caller":"traceutil/trace.go:171","msg":"trace[1000959603] linearizableReadLoop","detail":"{readStateIndex:2253; appliedIndex:2251; }","duration":"252.412984ms","start":"2026-06-08T03:37:49.960843Z","end":"2026-06-08T03:37:50.213256Z","steps":["trace[1000959603] 'read index received' (duration: 63.28233ms)","trace[1000959603] 'applied index is now lower than readState.Index' (duration: 189.129314ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:37:50.213324Z","caller":"traceutil/trace.go:171","msg":"trace[70113999] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"274.885816ms","start":"2026-06-08T03:37:49.938408Z","end":"2026-06-08T03:37:50.213294Z","steps":["trace[70113999] 'process raft request' (duration: 270.859124ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:37:50.213472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.772684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:37:50.213545Z","caller":"traceutil/trace.go:171","msg":"trace[1745084216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2171; }","duration":"239.880667ms","start":"2026-06-08T03:37:49.973645Z","end":"2026-06-08T03:37:50.213526Z","steps":["trace[1745084216] 'agreement among raft nodes before linearized reading' (duration: 239.767054ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:37:50.213574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.697209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:37:50.213687Z","caller":"traceutil/trace.go:171","msg":"trace[2058047567] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2171; }","duration":"252.878823ms","start":"2026-06-08T03:37:49.96078Z","end":"2026-06-08T03:37:50.213659Z","steps":["trace[2058047567] 'agreement among raft nodes before linearized reading' (duration: 252.601638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:37:50.213789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.841366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-08T03:37:50.213842Z","caller":"traceutil/trace.go:171","msg":"trace[1484520047] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2171; }","duration":"165.942119ms","start":"2026-06-08T03:37:50.047888Z","end":"2026-06-08T03:37:50.21383Z","steps":["trace[1484520047] 'agreement among raft nodes before linearized reading' (duration: 165.770515ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:38:59.737597Z","caller":"traceutil/trace.go:171","msg":"trace[102187690] transaction","detail":"{read_only:false; response_revision:2742; number_of_response:1; }","duration":"264.952746ms","start":"2026-06-08T03:38:59.472618Z","end":"2026-06-08T03:38:59.737571Z","steps":["trace[102187690] 'process raft request' (duration: 264.799823ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:38:59.752958Z","caller":"traceutil/trace.go:171","msg":"trace[1991675636] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"170.830908ms","start":"2026-06-08T03:38:59.582103Z","end":"2026-06-08T03:38:59.752934Z","steps":["trace[1991675636] 'process raft request' (duration: 170.592482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:42:58.549191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.031657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:42:58.549309Z","caller":"traceutil/trace.go:171","msg":"trace[350573706] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:4952; }","duration":"118.227761ms","start":"2026-06-08T03:42:58.431057Z","end":"2026-06-08T03:42:58.549285Z","steps":["trace[350573706] 'count revisions from in-memory index tree' (duration: 117.931404ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:42:59.141085Z","caller":"traceutil/trace.go:171","msg":"trace[960606620] linearizableReadLoop","detail":"{readStateIndex:5141; appliedIndex:5140; }","duration":"166.111407ms","start":"2026-06-08T03:42:58.974949Z","end":"2026-06-08T03:42:59.14106Z","steps":["trace[960606620] 'read index received' (duration: 165.941334ms)","trace[960606620] 'applied index is now lower than readState.Index' (duration: 168.863µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:42:59.141206Z","caller":"traceutil/trace.go:171","msg":"trace[1817783459] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"220.67597ms","start":"2026-06-08T03:42:58.920505Z","end":"2026-06-08T03:42:59.141181Z","steps":["trace[1817783459] 'process raft request' (duration: 220.392194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:42:59.141247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.275011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:42:59.141281Z","caller":"traceutil/trace.go:171","msg":"trace[1905399019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4956; }","duration":"166.378393ms","start":"2026-06-08T03:42:58.974893Z","end":"2026-06-08T03:42:59.141272Z","steps":["trace[1905399019] 'agreement among raft nodes before linearized reading' (duration: 166.297332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:42:59.147491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.756257ms","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-06-08T03:42:59.1476Z","caller":"traceutil/trace.go:171","msg":"trace[1882454355] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4957; }","duration":"131.93063ms","start":"2026-06-08T03:42:59.015649Z","end":"2026-06-08T03:42:59.147579Z","steps":["trace[1882454355] 'agreement among raft nodes before linearized reading' (duration: 131.608433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:43:10.813763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.738116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:43:10.813874Z","caller":"traceutil/trace.go:171","msg":"trace[230881119] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:5194; }","duration":"156.976181ms","start":"2026-06-08T03:43:10.656877Z","end":"2026-06-08T03:43:10.813853Z","steps":["trace[230881119] 'count revisions from in-memory index tree' (duration: 156.575612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:43:20.365348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.561622ms","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-06-08T03:43:20.365481Z","caller":"traceutil/trace.go:171","msg":"trace[1817108865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5382; }","duration":"106.788597ms","start":"2026-06-08T03:43:20.258665Z","end":"2026-06-08T03:43:20.365454Z","steps":["trace[1817108865] 'range keys from in-memory index tree' (duration: 106.215836ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:43:29.400018Z","caller":"traceutil/trace.go:171","msg":"trace[802618050] transaction","detail":"{read_only:false; response_revision:5506; number_of_response:1; }","duration":"124.59574ms","start":"2026-06-08T03:43:29.275396Z","end":"2026-06-08T03:43:29.399991Z","steps":["trace[802618050] 'process raft request' (duration: 124.314574ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:43:29.399985Z","caller":"traceutil/trace.go:171","msg":"trace[610485371] linearizableReadLoop","detail":"{readStateIndex:5708; appliedIndex:5707; }","duration":"103.986041ms","start":"2026-06-08T03:43:29.295961Z","end":"2026-06-08T03:43:29.399947Z","steps":["trace[610485371] 'read index received' (duration: 103.602453ms)","trace[610485371] 'applied index is now lower than readState.Index' (duration: 381.838µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:43:29.400349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.364928ms","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-06-08T03:43:29.400445Z","caller":"traceutil/trace.go:171","msg":"trace[914478351] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5506; }","duration":"104.540032ms","start":"2026-06-08T03:43:29.295891Z","end":"2026-06-08T03:43:29.400431Z","steps":["trace[914478351] 'agreement among raft nodes before linearized reading' (duration: 104.183154ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:44:43.798443Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2984} {"level":"info","ts":"2026-06-08T03:44:43.866868Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2984,"took":"66.871732ms","hash":134163641,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":34447360,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-08T03:44:43.866949Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":134163641,"revision":2984,"compact-revision":-1} {"level":"info","ts":"2026-06-08T03:49:37.840288Z","caller":"traceutil/trace.go:171","msg":"trace[656128727] transaction","detail":"{read_only:false; response_revision:8260; number_of_response:1; }","duration":"111.182432ms","start":"2026-06-08T03:49:37.72906Z","end":"2026-06-08T03:49:37.840243Z","steps":["trace[656128727] 'process raft request' (duration: 110.756293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:49:38.406529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.375014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:49:38.406825Z","caller":"traceutil/trace.go:171","msg":"trace[901318453] linearizableReadLoop","detail":"{readStateIndex:8554; appliedIndex:8552; }","duration":"125.413561ms","start":"2026-06-08T03:49:38.281395Z","end":"2026-06-08T03:49:38.406808Z","steps":["trace[901318453] 'read index received' (duration: 18.354084ms)","trace[901318453] 'applied index is now lower than readState.Index' (duration: 107.058427ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:49:38.406908Z","caller":"traceutil/trace.go:171","msg":"trace[1707902199] transaction","detail":"{read_only:false; response_revision:8264; number_of_response:1; }","duration":"203.874838ms","start":"2026-06-08T03:49:38.202989Z","end":"2026-06-08T03:49:38.406863Z","steps":["trace[1707902199] 'process raft request' (duration: 203.747055ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:49:38.406968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.559704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T03:49:38.406991Z","caller":"traceutil/trace.go:171","msg":"trace[1828974979] transaction","detail":"{read_only:false; response_revision:8263; number_of_response:1; }","duration":"204.365147ms","start":"2026-06-08T03:49:38.202591Z","end":"2026-06-08T03:49:38.406956Z","steps":["trace[1828974979] 'process raft request' (duration: 97.155507ms)","trace[1828974979] 'compare' (duration: 106.282602ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:49:38.40704Z","caller":"traceutil/trace.go:171","msg":"trace[1399686012] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:8264; }","duration":"125.680337ms","start":"2026-06-08T03:49:38.281343Z","end":"2026-06-08T03:49:38.407024Z","steps":["trace[1399686012] 'agreement among raft nodes before linearized reading' (duration: 125.526364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:49:38.407147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.414091ms","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-06-08T03:49:38.407225Z","caller":"traceutil/trace.go:171","msg":"trace[1140857631] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8264; }","duration":"125.492143ms","start":"2026-06-08T03:49:38.281719Z","end":"2026-06-08T03:49:38.407212Z","steps":["trace[1140857631] 'agreement among raft nodes before linearized reading' (duration: 125.238217ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:49:38.579779Z","caller":"traceutil/trace.go:171","msg":"trace[2103920911] transaction","detail":"{read_only:false; response_revision:8265; number_of_response:1; }","duration":"168.601641ms","start":"2026-06-08T03:49:38.411153Z","end":"2026-06-08T03:49:38.579755Z","steps":["trace[2103920911] 'process raft request' (duration: 168.442867ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:49:39.366335Z","caller":"traceutil/trace.go:171","msg":"trace[1864102815] transaction","detail":"{read_only:false; response_revision:8267; number_of_response:1; }","duration":"119.671403ms","start":"2026-06-08T03:49:39.246636Z","end":"2026-06-08T03:49:39.366308Z","steps":["trace[1864102815] 'process raft request' (duration: 119.4919ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:49:43.806136Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6125} {"level":"info","ts":"2026-06-08T03:49:43.908607Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6125,"took":"100.076536ms","hash":448173568,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":23166976,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-08T03:49:43.908677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":448173568,"revision":6125,"compact-revision":2984} {"level":"info","ts":"2026-06-08T03:50:07.304178Z","caller":"traceutil/trace.go:171","msg":"trace[1920040422] linearizableReadLoop","detail":"{readStateIndex:8771; appliedIndex:8770; }","duration":"330.265048ms","start":"2026-06-08T03:50:06.973878Z","end":"2026-06-08T03:50:07.304143Z","steps":["trace[1920040422] 'read index received' (duration: 298.733347ms)","trace[1920040422] 'applied index is now lower than readState.Index' (duration: 31.530101ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:50:07.304755Z","caller":"traceutil/trace.go:171","msg":"trace[1172709750] transaction","detail":"{read_only:false; response_revision:8472; number_of_response:1; }","duration":"338.418644ms","start":"2026-06-08T03:50:06.96632Z","end":"2026-06-08T03:50:07.304738Z","steps":["trace[1172709750] 'process raft request' (duration: 306.366851ms)","trace[1172709750] 'compare' (duration: 31.315437ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:50:07.305048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:50:06.966291Z","time spent":"338.556576ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T03:50:07.3053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.419972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:50:07.305343Z","caller":"traceutil/trace.go:171","msg":"trace[1695932948] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8472; }","duration":"331.493814ms","start":"2026-06-08T03:50:06.973839Z","end":"2026-06-08T03:50:07.305333Z","steps":["trace[1695932948] 'agreement among raft nodes before linearized reading' (duration: 331.414462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:50:07.305384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:50:06.973819Z","time spent":"331.558845ms","remote":"127.0.0.1:38174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T03:50:07.305589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.388715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T03:50:07.305632Z","caller":"traceutil/trace.go:171","msg":"trace[1000098143] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:8472; }","duration":"312.439555ms","start":"2026-06-08T03:50:06.993178Z","end":"2026-06-08T03:50:07.305617Z","steps":["trace[1000098143] 'agreement among raft nodes before linearized reading' (duration: 312.370914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:50:07.305668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T03:50:06.993171Z","time spent":"312.489256ms","remote":"127.0.0.1:38636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":3,"response size":31,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-08T03:50:10.932709Z","caller":"traceutil/trace.go:171","msg":"trace[1771939376] linearizableReadLoop","detail":"{readStateIndex:8789; appliedIndex:8788; }","duration":"184.647326ms","start":"2026-06-08T03:50:10.748039Z","end":"2026-06-08T03:50:10.932686Z","steps":["trace[1771939376] 'read index received' (duration: 184.516923ms)","trace[1771939376] 'applied index is now lower than readState.Index' (duration: 129.593µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:50:10.932822Z","caller":"traceutil/trace.go:171","msg":"trace[1570209815] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"188.170547ms","start":"2026-06-08T03:50:10.744608Z","end":"2026-06-08T03:50:10.932778Z","steps":["trace[1570209815] 'process raft request' (duration: 187.947422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:50:10.932959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.900321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T03:50:10.932995Z","caller":"traceutil/trace.go:171","msg":"trace[349955697] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:8490; }","duration":"184.992143ms","start":"2026-06-08T03:50:10.747993Z","end":"2026-06-08T03:50:10.932985Z","steps":["trace[349955697] 'agreement among raft nodes before linearized reading' (duration: 184.812489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:50:10.933052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.082661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lwdc2\" ","response":"range_response_count:1 size:6447"} {"level":"info","ts":"2026-06-08T03:50:10.93311Z","caller":"traceutil/trace.go:171","msg":"trace[600354376] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lwdc2; range_end:; response_count:1; response_revision:8490; }","duration":"113.201133ms","start":"2026-06-08T03:50:10.819893Z","end":"2026-06-08T03:50:10.933094Z","steps":["trace[600354376] 'agreement among raft nodes before linearized reading' (duration: 112.985909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T03:50:19.541472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.757804ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T03:50:19.541586Z","caller":"traceutil/trace.go:171","msg":"trace[1285494423] transaction","detail":"{read_only:false; response_revision:8576; number_of_response:1; }","duration":"194.640509ms","start":"2026-06-08T03:50:19.346926Z","end":"2026-06-08T03:50:19.541566Z","steps":["trace[1285494423] 'process raft request' (duration: 83.657452ms)","trace[1285494423] 'compare' (duration: 110.62129ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:50:19.683725Z","caller":"traceutil/trace.go:171","msg":"trace[1528155646] transaction","detail":"{read_only:false; response_revision:8577; number_of_response:1; }","duration":"105.681248ms","start":"2026-06-08T03:50:19.578012Z","end":"2026-06-08T03:50:19.683693Z","steps":["trace[1528155646] 'process raft request' (duration: 99.641626ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:50:19.687632Z","caller":"traceutil/trace.go:171","msg":"trace[942577255] transaction","detail":"{read_only:false; response_revision:8578; number_of_response:1; }","duration":"102.066617ms","start":"2026-06-08T03:50:19.58554Z","end":"2026-06-08T03:50:19.687607Z","steps":["trace[942577255] 'process raft request' (duration: 101.928254ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:50:39.879606Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023a0.wal"} {"level":"info","ts":"2026-06-08T03:51:36.338673Z","caller":"traceutil/trace.go:171","msg":"trace[268775264] transaction","detail":"{read_only:false; response_revision:9323; number_of_response:1; }","duration":"193.851631ms","start":"2026-06-08T03:51:36.144779Z","end":"2026-06-08T03:51:36.338631Z","steps":["trace[268775264] 'process raft request' (duration: 189.40937ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:52:24.292889Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf8c3a138c9a77a2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-08T03:52:24.298636Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-08T03:52:24.298771Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-08T03:54:43.813686Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8296} {"level":"info","ts":"2026-06-08T03:54:43.895987Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8296,"took":"78.303045ms","hash":4105870528,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":25403392,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-08T03:54:43.896094Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4105870528,"revision":8296,"compact-revision":6125} {"level":"warn","ts":"2026-06-08T03:55:21.533462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.017995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T03:55:21.53358Z","caller":"traceutil/trace.go:171","msg":"trace[691063529] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:11180; }","duration":"184.197369ms","start":"2026-06-08T03:55:21.34936Z","end":"2026-06-08T03:55:21.533557Z","steps":["trace[691063529] 'count revisions from in-memory index tree' (duration: 183.929614ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:55:21.533671Z","caller":"traceutil/trace.go:171","msg":"trace[444214349] linearizableReadLoop","detail":"{readStateIndex:11558; appliedIndex:11557; }","duration":"136.946327ms","start":"2026-06-08T03:55:21.396704Z","end":"2026-06-08T03:55:21.53365Z","steps":["trace[444214349] 'read index received' (duration: 69.760299ms)","trace[444214349] 'applied index is now lower than readState.Index' (duration: 67.185048ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T03:55:21.533744Z","caller":"traceutil/trace.go:171","msg":"trace[250940346] transaction","detail":"{read_only:false; response_revision:11181; number_of_response:1; }","duration":"175.639115ms","start":"2026-06-08T03:55:21.358094Z","end":"2026-06-08T03:55:21.533734Z","steps":["trace[250940346] 'process raft request' (duration: 108.404126ms)","trace[250940346] 'compare' (duration: 66.843731ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T03:55:21.533887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.186163ms","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-06-08T03:55:21.533913Z","caller":"traceutil/trace.go:171","msg":"trace[2032504475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11181; }","duration":"137.233553ms","start":"2026-06-08T03:55:21.396672Z","end":"2026-06-08T03:55:21.533905Z","steps":["trace[2032504475] 'agreement among raft nodes before linearized reading' (duration: 137.135701ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T03:59:43.829222Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10786} {"level":"info","ts":"2026-06-08T03:59:43.910203Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10786,"took":"77.323803ms","hash":1039653769,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":27758592,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-08T03:59:43.910271Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1039653769,"revision":10786,"compact-revision":8296} {"level":"warn","ts":"2026-06-08T04:01:52.253008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.907614ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-08T04:01:52.253389Z","caller":"traceutil/trace.go:171","msg":"trace[1882846765] linearizableReadLoop","detail":"{readStateIndex:14277; appliedIndex:14275; }","duration":"277.833636ms","start":"2026-06-08T04:01:51.975526Z","end":"2026-06-08T04:01:52.25336Z","steps":["trace[1882846765] 'read index received' (duration: 109.532824ms)","trace[1882846765] 'applied index is now lower than readState.Index' (duration: 168.297192ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:01:52.25374Z","caller":"traceutil/trace.go:171","msg":"trace[1345171988] transaction","detail":"{read_only:false; response_revision:13807; number_of_response:1; }","duration":"281.566782ms","start":"2026-06-08T04:01:51.972155Z","end":"2026-06-08T04:01:52.253722Z","steps":["trace[1345171988] 'process raft request' (duration: 281.016601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:01:52.253853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.249754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T04:01:52.253903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.34994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lwdc2\" ","response":"range_response_count:1 size:6447"} {"level":"info","ts":"2026-06-08T04:01:52.253971Z","caller":"traceutil/trace.go:171","msg":"trace[967143585] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13807; }","duration":"278.462819ms","start":"2026-06-08T04:01:51.975485Z","end":"2026-06-08T04:01:52.253948Z","steps":["trace[967143585] 'agreement among raft nodes before linearized reading' (duration: 278.235114ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:01:52.254017Z","caller":"traceutil/trace.go:171","msg":"trace[1626437684] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lwdc2; range_end:; response_count:1; response_revision:13807; }","duration":"210.523204ms","start":"2026-06-08T04:01:52.043466Z","end":"2026-06-08T04:01:52.253989Z","steps":["trace[1626437684] 'agreement among raft nodes before linearized reading' (duration: 210.237418ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:03:40.946251Z","caller":"traceutil/trace.go:171","msg":"trace[1391915175] transaction","detail":"{read_only:false; response_revision:14926; number_of_response:1; }","duration":"108.702107ms","start":"2026-06-08T04:03:40.837531Z","end":"2026-06-08T04:03:40.946233Z","steps":["trace[1391915175] 'process raft request' (duration: 108.444392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:03:41.130296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.699724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-06-08T04:03:41.130412Z","caller":"traceutil/trace.go:171","msg":"trace[365224581] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14926; }","duration":"149.869197ms","start":"2026-06-08T04:03:40.980517Z","end":"2026-06-08T04:03:41.130386Z","steps":["trace[365224581] 'range keys from in-memory index tree' (duration: 149.487729ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:04:43.835935Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12986} {"level":"info","ts":"2026-06-08T04:04:43.912428Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12986,"took":"73.615161ms","hash":1680558163,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":29941760,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-08T04:04:43.912499Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1680558163,"revision":12986,"compact-revision":10786} {"level":"info","ts":"2026-06-08T04:09:18.1966Z","caller":"traceutil/trace.go:171","msg":"trace[148371875] linearizableReadLoop","detail":"{readStateIndex:18076; appliedIndex:18075; }","duration":"222.221852ms","start":"2026-06-08T04:09:17.974353Z","end":"2026-06-08T04:09:18.196575Z","steps":["trace[148371875] 'read index received' (duration: 176.366929ms)","trace[148371875] 'applied index is now lower than readState.Index' (duration: 45.853923ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:09:18.196635Z","caller":"traceutil/trace.go:171","msg":"trace[1606269820] transaction","detail":"{read_only:false; response_revision:17486; number_of_response:1; }","duration":"276.349465ms","start":"2026-06-08T04:09:17.920249Z","end":"2026-06-08T04:09:18.196599Z","steps":["trace[1606269820] 'process raft request' (duration: 230.561393ms)","trace[1606269820] 'compare' (duration: 45.653879ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:09:18.196732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.369515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:09:18.196783Z","caller":"traceutil/trace.go:171","msg":"trace[1179936520] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17486; }","duration":"222.467537ms","start":"2026-06-08T04:09:17.974296Z","end":"2026-06-08T04:09:18.196764Z","steps":["trace[1179936520] 'agreement among raft nodes before linearized reading' (duration: 222.382575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:09:18.451443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.272015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-08T04:09:18.451573Z","caller":"traceutil/trace.go:171","msg":"trace[1680093923] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:17486; }","duration":"143.441189ms","start":"2026-06-08T04:09:18.308088Z","end":"2026-06-08T04:09:18.451529Z","steps":["trace[1680093923] 'count revisions from in-memory index tree' (duration: 143.159913ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:09:18.648436Z","caller":"traceutil/trace.go:171","msg":"trace[55306389] linearizableReadLoop","detail":"{readStateIndex:18077; appliedIndex:18076; }","duration":"310.199363ms","start":"2026-06-08T04:09:18.338184Z","end":"2026-06-08T04:09:18.648383Z","steps":["trace[55306389] 'read index received' (duration: 310.02082ms)","trace[55306389] 'applied index is now lower than readState.Index' (duration: 177.543µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:09:18.648656Z","caller":"traceutil/trace.go:171","msg":"trace[1224913961] transaction","detail":"{read_only:false; response_revision:17487; number_of_response:1; }","duration":"320.192806ms","start":"2026-06-08T04:09:18.32845Z","end":"2026-06-08T04:09:18.648642Z","steps":["trace[1224913961] 'process raft request' (duration: 319.777548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:09:18.648772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:09:18.328418Z","time spent":"320.274968ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:09:18.648882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.682923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-08T04:09:18.648992Z","caller":"traceutil/trace.go:171","msg":"trace[98694219] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:17487; }","duration":"310.844176ms","start":"2026-06-08T04:09:18.338129Z","end":"2026-06-08T04:09:18.648973Z","steps":["trace[98694219] 'agreement among raft nodes before linearized reading' (duration: 310.659652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:09:18.649042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:09:18.338066Z","time spent":"310.965718ms","remote":"127.0.0.1:38614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":33,"response size":32,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"info","ts":"2026-06-08T04:09:18.731919Z","caller":"traceutil/trace.go:171","msg":"trace[1540514198] transaction","detail":"{read_only:false; response_revision:17488; number_of_response:1; }","duration":"264.82682ms","start":"2026-06-08T04:09:18.467055Z","end":"2026-06-08T04:09:18.731882Z","steps":["trace[1540514198] 'process raft request' (duration: 206.829169ms)","trace[1540514198] 'compare' (duration: 57.746536ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:09:18.732162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.795586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-08T04:09:18.732248Z","caller":"traceutil/trace.go:171","msg":"trace[757207409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17488; }","duration":"199.918358ms","start":"2026-06-08T04:09:18.532312Z","end":"2026-06-08T04:09:18.73223Z","steps":["trace[757207409] 'agreement among raft nodes before linearized reading' (duration: 199.681503ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:09:43.843204Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15345} {"level":"info","ts":"2026-06-08T04:09:43.937124Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15345,"took":"90.514622ms","hash":1696277022,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":32210944,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-08T04:09:43.93721Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1696277022,"revision":15345,"compact-revision":12986} {"level":"info","ts":"2026-06-08T04:13:04.535924Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf8c3a138c9a77a2","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-08T04:13:04.540077Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-08T04:13:04.540165Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-08T04:14:43.850738Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17784} {"level":"info","ts":"2026-06-08T04:14:43.948187Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17784,"took":"94.01671ms","hash":2639025200,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":33935360,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-08T04:14:43.948249Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2639025200,"revision":17784,"compact-revision":15345} {"level":"info","ts":"2026-06-08T04:15:03.304654Z","caller":"traceutil/trace.go:171","msg":"trace[938781148] transaction","detail":"{read_only:false; response_revision:20185; number_of_response:1; }","duration":"133.083315ms","start":"2026-06-08T04:15:03.171541Z","end":"2026-06-08T04:15:03.304624Z","steps":["trace[938781148] 'process raft request' (duration: 132.917582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:15:03.582142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.164276ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-08T04:15:03.582352Z","caller":"traceutil/trace.go:171","msg":"trace[1888732987] transaction","detail":"{read_only:false; response_revision:20186; number_of_response:1; }","duration":"170.504475ms","start":"2026-06-08T04:15:03.411796Z","end":"2026-06-08T04:15:03.582301Z","steps":["trace[1888732987] 'process raft request' (duration: 39.093584ms)","trace[1888732987] 'compare' (duration: 131.064804ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:15:03.944456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.947915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:15:03.944528Z","caller":"traceutil/trace.go:171","msg":"trace[1521196721] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:20189; }","duration":"235.070147ms","start":"2026-06-08T04:15:03.709442Z","end":"2026-06-08T04:15:03.944513Z","steps":["trace[1521196721] 'range keys from in-memory index tree' (duration: 234.871653ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:15:04.195146Z","caller":"traceutil/trace.go:171","msg":"trace[953362811] transaction","detail":"{read_only:false; response_revision:20190; number_of_response:1; }","duration":"202.72719ms","start":"2026-06-08T04:15:03.992394Z","end":"2026-06-08T04:15:04.195121Z","steps":["trace[953362811] 'process raft request' (duration: 202.569667ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:15:04.210517Z","caller":"traceutil/trace.go:171","msg":"trace[990261786] transaction","detail":"{read_only:false; response_revision:20191; number_of_response:1; }","duration":"216.594791ms","start":"2026-06-08T04:15:03.993898Z","end":"2026-06-08T04:15:04.210493Z","steps":["trace[990261786] 'process raft request' (duration: 216.446988ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:15:04.21083Z","caller":"traceutil/trace.go:171","msg":"trace[730830963] transaction","detail":"{read_only:false; response_revision:20192; number_of_response:1; }","duration":"216.672503ms","start":"2026-06-08T04:15:03.994114Z","end":"2026-06-08T04:15:04.210787Z","steps":["trace[730830963] 'process raft request' (duration: 216.344686ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:15:04.701754Z","caller":"traceutil/trace.go:171","msg":"trace[1383758718] linearizableReadLoop","detail":"{readStateIndex:20874; appliedIndex:20873; }","duration":"209.193581ms","start":"2026-06-08T04:15:04.492535Z","end":"2026-06-08T04:15:04.701729Z","steps":["trace[1383758718] 'read index received' (duration: 209.045758ms)","trace[1383758718] 'applied index is now lower than readState.Index' (duration: 146.603µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:15:04.701814Z","caller":"traceutil/trace.go:171","msg":"trace[435874153] transaction","detail":"{read_only:false; response_revision:20193; number_of_response:1; }","duration":"221.723366ms","start":"2026-06-08T04:15:04.480052Z","end":"2026-06-08T04:15:04.701775Z","steps":["trace[435874153] 'process raft request' (duration: 221.522692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:15:04.702008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.447786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-06-08T04:15:04.702063Z","caller":"traceutil/trace.go:171","msg":"trace[1491886437] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:20193; }","duration":"209.512128ms","start":"2026-06-08T04:15:04.49253Z","end":"2026-06-08T04:15:04.702042Z","steps":["trace[1491886437] 'agreement among raft nodes before linearized reading' (duration: 209.297063ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:15:05.063124Z","caller":"traceutil/trace.go:171","msg":"trace[888123820] linearizableReadLoop","detail":"{readStateIndex:20875; appliedIndex:20874; }","duration":"279.761054ms","start":"2026-06-08T04:15:04.783322Z","end":"2026-06-08T04:15:05.063084Z","steps":["trace[888123820] 'read index received' (duration: 279.585151ms)","trace[888123820] 'applied index is now lower than readState.Index' (duration: 175.113µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:15:05.063198Z","caller":"traceutil/trace.go:171","msg":"trace[355839527] transaction","detail":"{read_only:false; response_revision:20194; number_of_response:1; }","duration":"356.545755ms","start":"2026-06-08T04:15:04.706617Z","end":"2026-06-08T04:15:05.063163Z","steps":["trace[355839527] 'process raft request' (duration: 356.30834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:15:05.063339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.991139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-08T04:15:05.06335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:15:04.706588Z","time spent":"356.677148ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:15:05.063373Z","caller":"traceutil/trace.go:171","msg":"trace[276719907] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:20194; }","duration":"280.104092ms","start":"2026-06-08T04:15:04.78326Z","end":"2026-06-08T04:15:05.063364Z","steps":["trace[276719907] 'agreement among raft nodes before linearized reading' (duration: 279.958278ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:19:05.24001Z","caller":"traceutil/trace.go:171","msg":"trace[5179387] transaction","detail":"{read_only:false; response_revision:22647; number_of_response:1; }","duration":"127.910689ms","start":"2026-06-08T04:19:05.112075Z","end":"2026-06-08T04:19:05.239985Z","steps":["trace[5179387] 'process raft request' (duration: 127.741816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:19:05.513701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.940026ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-08T04:19:05.513933Z","caller":"traceutil/trace.go:171","msg":"trace[1505393217] linearizableReadLoop","detail":"{readStateIndex:23406; appliedIndex:23403; }","duration":"290.058985ms","start":"2026-06-08T04:19:05.223858Z","end":"2026-06-08T04:19:05.513917Z","steps":["trace[1505393217] 'read index received' (duration: 16.017846ms)","trace[1505393217] 'applied index is now lower than readState.Index' (duration: 274.040049ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:19:05.514033Z","caller":"traceutil/trace.go:171","msg":"trace[1553165462] transaction","detail":"{read_only:false; response_revision:22648; number_of_response:1; }","duration":"392.755291ms","start":"2026-06-08T04:19:05.121264Z","end":"2026-06-08T04:19:05.514019Z","steps":["trace[1553165462] 'process raft request' (duration: 184.386016ms)","trace[1553165462] 'compare' (duration: 207.795173ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:19:05.514102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:19:05.121239Z","time spent":"392.828692ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:19:05.514447Z","caller":"traceutil/trace.go:171","msg":"trace[420850972] transaction","detail":"{read_only:false; response_revision:22649; number_of_response:1; }","duration":"378.853278ms","start":"2026-06-08T04:19:05.135583Z","end":"2026-06-08T04:19:05.514436Z","steps":["trace[420850972] 'process raft request' (duration: 378.234166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:19:05.514506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:19:05.135559Z","time spent":"378.918059ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:19:05.514858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.617796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-08T04:19:05.514926Z","caller":"traceutil/trace.go:171","msg":"trace[1575621870] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:22649; }","duration":"136.741579ms","start":"2026-06-08T04:19:05.378171Z","end":"2026-06-08T04:19:05.514913Z","steps":["trace[1575621870] 'agreement among raft nodes before linearized reading' (duration: 136.593786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:19:05.514969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.099735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"} {"level":"info","ts":"2026-06-08T04:19:05.515052Z","caller":"traceutil/trace.go:171","msg":"trace[1383654022] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:22649; }","duration":"291.229738ms","start":"2026-06-08T04:19:05.223804Z","end":"2026-06-08T04:19:05.515034Z","steps":["trace[1383654022] 'agreement among raft nodes before linearized reading' (duration: 290.928732ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:19:43.858208Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20068} {"level":"info","ts":"2026-06-08T04:19:43.961675Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20068,"took":"100.371349ms","hash":2563281758,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":41103360,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-06-08T04:19:43.961737Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2563281758,"revision":20068,"compact-revision":17784} {"level":"info","ts":"2026-06-08T04:22:33.315962Z","caller":"traceutil/trace.go:171","msg":"trace[1912618563] linearizableReadLoop","detail":"{readStateIndex:25582; appliedIndex:25581; }","duration":"103.604425ms","start":"2026-06-08T04:22:33.212339Z","end":"2026-06-08T04:22:33.315943Z","steps":["trace[1912618563] 'read index received' (duration: 103.454342ms)","trace[1912618563] 'applied index is now lower than readState.Index' (duration: 149.083µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:33.31618Z","caller":"traceutil/trace.go:171","msg":"trace[284150112] transaction","detail":"{read_only:false; response_revision:24769; number_of_response:1; }","duration":"107.362043ms","start":"2026-06-08T04:22:33.208808Z","end":"2026-06-08T04:22:33.31617Z","steps":["trace[284150112] 'process raft request' (duration: 107.027086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:33.31638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.027784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-06-08T04:22:33.31641Z","caller":"traceutil/trace.go:171","msg":"trace[76713252] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24769; }","duration":"104.088915ms","start":"2026-06-08T04:22:33.212311Z","end":"2026-06-08T04:22:33.3164Z","steps":["trace[76713252] 'agreement among raft nodes before linearized reading' (duration: 103.994063ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:33.477293Z","caller":"traceutil/trace.go:171","msg":"trace[1610609326] transaction","detail":"{read_only:false; response_revision:24770; number_of_response:1; }","duration":"151.780565ms","start":"2026-06-08T04:22:33.325493Z","end":"2026-06-08T04:22:33.477274Z","steps":["trace[1610609326] 'process raft request' (duration: 93.807827ms)","trace[1610609326] 'compare' (duration: 57.685252ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:33.477451Z","caller":"traceutil/trace.go:171","msg":"trace[486372583] linearizableReadLoop","detail":"{readStateIndex:25583; appliedIndex:25582; }","duration":"139.432823ms","start":"2026-06-08T04:22:33.338002Z","end":"2026-06-08T04:22:33.477435Z","steps":["trace[486372583] 'read index received' (duration: 81.339483ms)","trace[486372583] 'applied index is now lower than readState.Index' (duration: 58.09284ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:22:33.477859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.836931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-08T04:22:33.477893Z","caller":"traceutil/trace.go:171","msg":"trace[1696702049] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:24771; }","duration":"139.884842ms","start":"2026-06-08T04:22:33.337999Z","end":"2026-06-08T04:22:33.477884Z","steps":["trace[1696702049] 'agreement among raft nodes before linearized reading' (duration: 139.667637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:33.840721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.582279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-08T04:22:33.840795Z","caller":"traceutil/trace.go:171","msg":"trace[1911213461] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:24771; }","duration":"243.671261ms","start":"2026-06-08T04:22:33.597106Z","end":"2026-06-08T04:22:33.840777Z","steps":["trace[1911213461] 'count revisions from in-memory index tree' (duration: 243.417197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:33.84109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.206759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-dhcp-agent-default-xqthn.18b6ffacb6cd88bf\" ","response":"range_response_count:1 size:957"} {"level":"info","ts":"2026-06-08T04:22:33.841162Z","caller":"traceutil/trace.go:171","msg":"trace[1616879929] range","detail":"{range_begin:/registry/events/openstack/neutron-dhcp-agent-default-xqthn.18b6ffacb6cd88bf; range_end:; response_count:1; response_revision:24771; }","duration":"109.511685ms","start":"2026-06-08T04:22:33.731629Z","end":"2026-06-08T04:22:33.84114Z","steps":["trace[1616879929] 'range keys from in-memory index tree' (duration: 109.054156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:33.841294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.291056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-08T04:22:33.841376Z","caller":"traceutil/trace.go:171","msg":"trace[2120629420] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24771; }","duration":"221.430289ms","start":"2026-06-08T04:22:33.619922Z","end":"2026-06-08T04:22:33.841352Z","steps":["trace[2120629420] 'range keys from in-memory index tree' (duration: 221.116943ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:34.350251Z","caller":"traceutil/trace.go:171","msg":"trace[1754273466] transaction","detail":"{read_only:false; response_revision:24772; number_of_response:1; }","duration":"507.193916ms","start":"2026-06-08T04:22:33.843032Z","end":"2026-06-08T04:22:34.350226Z","steps":["trace[1754273466] 'process raft request' (duration: 507.015043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:34.350457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:33.843009Z","time spent":"507.329478ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":939,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:34.370223Z","caller":"traceutil/trace.go:171","msg":"trace[1306289669] transaction","detail":"{read_only:false; response_revision:24773; number_of_response:1; }","duration":"523.514458ms","start":"2026-06-08T04:22:33.846683Z","end":"2026-06-08T04:22:34.370198Z","steps":["trace[1306289669] 'process raft request' (duration: 523.383875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:34.37035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:33.846666Z","time spent":"523.618409ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:34.37057Z","caller":"traceutil/trace.go:171","msg":"trace[1399980880] transaction","detail":"{read_only:false; response_revision:24775; number_of_response:1; }","duration":"347.780017ms","start":"2026-06-08T04:22:34.022769Z","end":"2026-06-08T04:22:34.370549Z","steps":["trace[1399980880] 'process raft request' (duration: 347.656994ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:34.370582Z","caller":"traceutil/trace.go:171","msg":"trace[1365948031] transaction","detail":"{read_only:false; response_revision:24774; number_of_response:1; }","duration":"522.870195ms","start":"2026-06-08T04:22:33.847681Z","end":"2026-06-08T04:22:34.370551Z","steps":["trace[1365948031] 'process raft request' (duration: 522.487307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:34.370716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:34.022736Z","time spent":"347.902128ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:22:34.370776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:33.847673Z","time spent":"523.003257ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:34.370907Z","caller":"traceutil/trace.go:171","msg":"trace[1102710211] linearizableReadLoop","detail":"{readStateIndex:25587; appliedIndex:25585; }","duration":"521.18549ms","start":"2026-06-08T04:22:33.849682Z","end":"2026-06-08T04:22:34.370867Z","steps":["trace[1102710211] 'read index received' (duration: 500.676714ms)","trace[1102710211] 'applied index is now lower than readState.Index' (duration: 20.507736ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:34.37106Z","caller":"traceutil/trace.go:171","msg":"trace[1796860777] transaction","detail":"{read_only:false; response_revision:24776; number_of_response:1; }","duration":"295.151807ms","start":"2026-06-08T04:22:34.075896Z","end":"2026-06-08T04:22:34.371048Z","steps":["trace[1796860777] 'process raft request' (duration: 294.613266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:34.371205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.527338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-08T04:22:34.371245Z","caller":"traceutil/trace.go:171","msg":"trace[1635118202] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24778; }","duration":"521.588468ms","start":"2026-06-08T04:22:33.849646Z","end":"2026-06-08T04:22:34.371234Z","steps":["trace[1635118202] 'agreement among raft nodes before linearized reading' (duration: 521.425005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:34.371278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:33.849594Z","time spent":"521.67716ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T04:22:34.371423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.315041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-08T04:22:34.371455Z","caller":"traceutil/trace.go:171","msg":"trace[927098788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24778; }","duration":"515.361662ms","start":"2026-06-08T04:22:33.856086Z","end":"2026-06-08T04:22:34.371448Z","steps":["trace[927098788] 'agreement among raft nodes before linearized reading' (duration: 515.26562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:34.371472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.131937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"warn","ts":"2026-06-08T04:22:34.37148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:33.856076Z","time spent":"515.399053ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-08T04:22:34.371558Z","caller":"traceutil/trace.go:171","msg":"trace[1352314850] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:24778; }","duration":"141.208549ms","start":"2026-06-08T04:22:34.230288Z","end":"2026-06-08T04:22:34.371497Z","steps":["trace[1352314850] 'agreement among raft nodes before linearized reading' (duration: 141.108117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:34.371561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.318503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:22:34.371589Z","caller":"traceutil/trace.go:171","msg":"trace[962418093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24778; }","duration":"396.373143ms","start":"2026-06-08T04:22:33.975208Z","end":"2026-06-08T04:22:34.371581Z","steps":["trace[962418093] 'agreement among raft nodes before linearized reading' (duration: 396.331253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:34.371612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:33.975188Z","time spent":"396.419685ms","remote":"127.0.0.1:38174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-08T04:22:39.741054Z","caller":"traceutil/trace.go:171","msg":"trace[708170170] linearizableReadLoop","detail":"{readStateIndex:25640; appliedIndex:25639; }","duration":"231.499824ms","start":"2026-06-08T04:22:39.509524Z","end":"2026-06-08T04:22:39.741023Z","steps":["trace[708170170] 'read index received' (duration: 231.122326ms)","trace[708170170] 'applied index is now lower than readState.Index' (duration: 376.278µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:39.741714Z","caller":"traceutil/trace.go:171","msg":"trace[451244624] transaction","detail":"{read_only:false; response_revision:24826; number_of_response:1; }","duration":"247.241943ms","start":"2026-06-08T04:22:39.494455Z","end":"2026-06-08T04:22:39.741697Z","steps":["trace[451244624] 'process raft request' (duration: 246.262033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:39.742363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.823471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-06-08T04:22:39.742415Z","caller":"traceutil/trace.go:171","msg":"trace[479779831] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:24826; }","duration":"232.931073ms","start":"2026-06-08T04:22:39.509471Z","end":"2026-06-08T04:22:39.742402Z","steps":["trace[479779831] 'agreement among raft nodes before linearized reading' (duration: 232.630397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:40.338707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.94293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:22:40.338796Z","caller":"traceutil/trace.go:171","msg":"trace[868826153] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:24828; }","duration":"224.108323ms","start":"2026-06-08T04:22:40.114663Z","end":"2026-06-08T04:22:40.338771Z","steps":["trace[868826153] 'count revisions from in-memory index tree' (duration: 223.820438ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:40.88143Z","caller":"traceutil/trace.go:171","msg":"trace[98692720] transaction","detail":"{read_only:false; response_revision:24830; number_of_response:1; }","duration":"492.058538ms","start":"2026-06-08T04:22:40.389348Z","end":"2026-06-08T04:22:40.881407Z","steps":["trace[98692720] 'process raft request' (duration: 491.929116ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:40.881569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.389308Z","time spent":"492.18517ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:22:41.160821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.20376ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-08T04:22:41.161373Z","caller":"traceutil/trace.go:171","msg":"trace[153681295] transaction","detail":"{read_only:false; response_revision:24831; number_of_response:1; }","duration":"768.569827ms","start":"2026-06-08T04:22:40.392755Z","end":"2026-06-08T04:22:41.161325Z","steps":["trace[153681295] 'process raft request' (duration: 563.716954ms)","trace[153681295] 'compare' (duration: 204.040257ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:41.161475Z","caller":"traceutil/trace.go:171","msg":"trace[331161986] transaction","detail":"{read_only:false; response_revision:24834; number_of_response:1; }","duration":"530.562591ms","start":"2026-06-08T04:22:40.630894Z","end":"2026-06-08T04:22:41.161457Z","steps":["trace[331161986] 'process raft request' (duration: 530.434288ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:41.161481Z","caller":"traceutil/trace.go:171","msg":"trace[1689692999] linearizableReadLoop","detail":"{readStateIndex:25647; appliedIndex:25644; }","duration":"764.923344ms","start":"2026-06-08T04:22:40.396533Z","end":"2026-06-08T04:22:41.161457Z","steps":["trace[1689692999] 'read index received' (duration: 484.886134ms)","trace[1689692999] 'applied index is now lower than readState.Index' (duration: 280.03556ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:41.161506Z","caller":"traceutil/trace.go:171","msg":"trace[1441625248] transaction","detail":"{read_only:false; response_revision:24835; number_of_response:1; }","duration":"361.415034ms","start":"2026-06-08T04:22:40.800053Z","end":"2026-06-08T04:22:41.161468Z","steps":["trace[1441625248] 'process raft request' (duration: 361.341572ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.161569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.630861Z","time spent":"530.666933ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:22:41.161577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.392724Z","time spent":"768.73188ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:22:41.161677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.800029Z","time spent":"361.561087ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:22:41.161698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.143378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-08T04:22:41.16155Z","caller":"traceutil/trace.go:171","msg":"trace[1896213610] transaction","detail":"{read_only:false; response_revision:24833; number_of_response:1; }","duration":"767.72103ms","start":"2026-06-08T04:22:40.393726Z","end":"2026-06-08T04:22:41.161447Z","steps":["trace[1896213610] 'process raft request' (duration: 767.528646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.16182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.122496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-08T04:22:41.161833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.936159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-08T04:22:41.16182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.152408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-08T04:22:41.161858Z","caller":"traceutil/trace.go:171","msg":"trace[426090573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24835; }","duration":"762.167488ms","start":"2026-06-08T04:22:40.39968Z","end":"2026-06-08T04:22:41.161847Z","steps":["trace[426090573] 'agreement among raft nodes before linearized reading' (duration: 762.082826ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:41.16178Z","caller":"traceutil/trace.go:171","msg":"trace[2012646120] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24835; }","duration":"765.26673ms","start":"2026-06-08T04:22:40.396495Z","end":"2026-06-08T04:22:41.161762Z","steps":["trace[2012646120] 'agreement among raft nodes before linearized reading' (duration: 765.049525ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.161909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.399673Z","time spent":"762.226969ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-08T04:22:41.161911Z","caller":"traceutil/trace.go:171","msg":"trace[1421572128] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24835; }","duration":"765.29026ms","start":"2026-06-08T04:22:40.396601Z","end":"2026-06-08T04:22:41.161892Z","steps":["trace[1421572128] 'agreement among raft nodes before linearized reading' (duration: 765.022495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.16191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.547543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-06-08T04:22:41.161928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.396484Z","time spent":"765.427124ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-08T04:22:41.161956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.396577Z","time spent":"765.370283ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-08T04:22:41.161966Z","caller":"traceutil/trace.go:171","msg":"trace[58705336] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24835; }","duration":"760.623016ms","start":"2026-06-08T04:22:40.401325Z","end":"2026-06-08T04:22:41.161948Z","steps":["trace[58705336] 'agreement among raft nodes before linearized reading' (duration: 760.404531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.162015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.401314Z","time spent":"760.692427ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T04:22:41.161727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.993939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-08T04:22:41.162017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.393705Z","time spent":"768.126048ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:41.16174Z","caller":"traceutil/trace.go:171","msg":"trace[1304489244] transaction","detail":"{read_only:false; response_revision:24832; number_of_response:1; }","duration":"768.72446ms","start":"2026-06-08T04:22:40.39297Z","end":"2026-06-08T04:22:41.161694Z","steps":["trace[1304489244] 'process raft request' (duration: 768.067927ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:41.162165Z","caller":"traceutil/trace.go:171","msg":"trace[380033789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24835; }","duration":"186.405517ms","start":"2026-06-08T04:22:40.975688Z","end":"2026-06-08T04:22:41.162094Z","steps":["trace[380033789] 'agreement among raft nodes before linearized reading' (duration: 186.002759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.162229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.392956Z","time spent":"769.233601ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:22:41.161789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.586084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-08T04:22:41.162295Z","caller":"traceutil/trace.go:171","msg":"trace[400692593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24835; }","duration":"228.118366ms","start":"2026-06-08T04:22:40.934163Z","end":"2026-06-08T04:22:41.162282Z","steps":["trace[400692593] 'agreement among raft nodes before linearized reading' (duration: 227.525063ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:41.161868Z","caller":"traceutil/trace.go:171","msg":"trace[1226233666] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:24835; }","duration":"689.007491ms","start":"2026-06-08T04:22:40.472846Z","end":"2026-06-08T04:22:41.161854Z","steps":["trace[1226233666] 'agreement among raft nodes before linearized reading' (duration: 688.914839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.162392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.472822Z","time spent":"689.558793ms","remote":"127.0.0.1:38578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":54,"response size":32,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-06-08T04:22:41.161833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.610302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11716"} {"level":"info","ts":"2026-06-08T04:22:41.162437Z","caller":"traceutil/trace.go:171","msg":"trace[1337904846] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24835; }","duration":"251.262926ms","start":"2026-06-08T04:22:40.911162Z","end":"2026-06-08T04:22:41.162425Z","steps":["trace[1337904846] 'agreement among raft nodes before linearized reading' (duration: 250.53377ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.161721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.831224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:22:41.162535Z","caller":"traceutil/trace.go:171","msg":"trace[71380341] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:24835; }","duration":"588.696523ms","start":"2026-06-08T04:22:40.573816Z","end":"2026-06-08T04:22:41.162513Z","steps":["trace[71380341] 'agreement among raft nodes before linearized reading' (duration: 587.809554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.162584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:40.573793Z","time spent":"588.776035ms","remote":"127.0.0.1:49514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":30,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true "} {"level":"info","ts":"2026-06-08T04:22:41.43375Z","caller":"traceutil/trace.go:171","msg":"trace[1247324355] transaction","detail":"{read_only:false; response_revision:24836; number_of_response:1; }","duration":"266.822762ms","start":"2026-06-08T04:22:41.1669Z","end":"2026-06-08T04:22:41.433723Z","steps":["trace[1247324355] 'process raft request' (duration: 266.644369ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:41.474235Z","caller":"traceutil/trace.go:171","msg":"trace[793673454] transaction","detail":"{read_only:false; response_revision:24837; number_of_response:1; }","duration":"306.871336ms","start":"2026-06-08T04:22:41.167338Z","end":"2026-06-08T04:22:41.474209Z","steps":["trace[793673454] 'process raft request' (duration: 306.729463ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.474388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:41.167326Z","time spent":"306.965678ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:41.474583Z","caller":"traceutil/trace.go:171","msg":"trace[1665265789] transaction","detail":"{read_only:false; response_revision:24838; number_of_response:1; }","duration":"306.671421ms","start":"2026-06-08T04:22:41.167887Z","end":"2026-06-08T04:22:41.474559Z","steps":["trace[1665265789] 'process raft request' (duration: 306.277023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.474697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:41.16786Z","time spent":"306.778663ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:41.474666Z","caller":"traceutil/trace.go:171","msg":"trace[1415035135] transaction","detail":"{read_only:false; response_revision:24839; number_of_response:1; }","duration":"306.452027ms","start":"2026-06-08T04:22:41.168182Z","end":"2026-06-08T04:22:41.474634Z","steps":["trace[1415035135] 'process raft request' (duration: 306.272873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.474857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:41.168168Z","time spent":"306.588219ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:41.474958Z","caller":"traceutil/trace.go:171","msg":"trace[95733969] linearizableReadLoop","detail":"{readStateIndex:25654; appliedIndex:25649; }","duration":"305.060169ms","start":"2026-06-08T04:22:41.169877Z","end":"2026-06-08T04:22:41.474937Z","steps":["trace[95733969] 'read index received' (duration: 263.709658ms)","trace[95733969] 'applied index is now lower than readState.Index' (duration: 41.349431ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:41.474981Z","caller":"traceutil/trace.go:171","msg":"trace[301376377] transaction","detail":"{read_only:false; response_revision:24840; number_of_response:1; }","duration":"306.494238ms","start":"2026-06-08T04:22:41.168454Z","end":"2026-06-08T04:22:41.474948Z","steps":["trace[301376377] 'process raft request' (duration: 306.148961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.475156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:41.168445Z","time spent":"306.62281ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:22:41.475161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.271743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11716"} {"level":"info","ts":"2026-06-08T04:22:41.475223Z","caller":"traceutil/trace.go:171","msg":"trace[1355539280] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24841; }","duration":"305.366225ms","start":"2026-06-08T04:22:41.169838Z","end":"2026-06-08T04:22:41.475204Z","steps":["trace[1355539280] 'agreement among raft nodes before linearized reading' (duration: 305.177811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:41.475298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:41.169826Z","time spent":"305.458517ms","remote":"127.0.0.1:38578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11740,"request content":"key:\"/registry/deployments/openstack/glance-api\" "} {"level":"info","ts":"2026-06-08T04:22:41.475251Z","caller":"traceutil/trace.go:171","msg":"trace[766876989] transaction","detail":"{read_only:false; response_revision:24841; number_of_response:1; }","duration":"128.45356ms","start":"2026-06-08T04:22:41.346722Z","end":"2026-06-08T04:22:41.475175Z","steps":["trace[766876989] 'process raft request' (duration: 128.153124ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:42.040575Z","caller":"traceutil/trace.go:171","msg":"trace[690181127] linearizableReadLoop","detail":"{readStateIndex:25656; appliedIndex:25655; }","duration":"195.453212ms","start":"2026-06-08T04:22:41.845094Z","end":"2026-06-08T04:22:42.040548Z","steps":["trace[690181127] 'read index received' (duration: 195.178646ms)","trace[690181127] 'applied index is now lower than readState.Index' (duration: 273.466µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:42.040945Z","caller":"traceutil/trace.go:171","msg":"trace[697548711] transaction","detail":"{read_only:false; response_revision:24842; number_of_response:1; }","duration":"285.94483ms","start":"2026-06-08T04:22:41.754985Z","end":"2026-06-08T04:22:42.04093Z","steps":["trace[697548711] 'process raft request' (duration: 285.378349ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:42.041269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.156346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-08T04:22:42.041304Z","caller":"traceutil/trace.go:171","msg":"trace[563591618] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:24842; }","duration":"196.263518ms","start":"2026-06-08T04:22:41.845033Z","end":"2026-06-08T04:22:42.041296Z","steps":["trace[563591618] 'agreement among raft nodes before linearized reading' (duration: 196.091824ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:42.194544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.302811ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-08T04:22:42.19471Z","caller":"traceutil/trace.go:171","msg":"trace[1694569478] linearizableReadLoop","detail":"{readStateIndex:25657; appliedIndex:25656; }","duration":"154.008779ms","start":"2026-06-08T04:22:42.040654Z","end":"2026-06-08T04:22:42.194663Z","steps":["trace[1694569478] 'read index received' (duration: 14.480024ms)","trace[1694569478] 'applied index is now lower than readState.Index' (duration: 139.526225ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:22:42.194825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.574141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:22:42.194861Z","caller":"traceutil/trace.go:171","msg":"trace[93422145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24842; }","duration":"218.653753ms","start":"2026-06-08T04:22:41.976197Z","end":"2026-06-08T04:22:42.194851Z","steps":["trace[93422145] 'agreement among raft nodes before linearized reading' (duration: 218.548951ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:43.420333Z","caller":"traceutil/trace.go:171","msg":"trace[422952951] transaction","detail":"{read_only:false; response_revision:24845; number_of_response:1; }","duration":"251.285837ms","start":"2026-06-08T04:22:43.169018Z","end":"2026-06-08T04:22:43.420304Z","steps":["trace[422952951] 'process raft request' (duration: 251.081503ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:43.421145Z","caller":"traceutil/trace.go:171","msg":"trace[1707949460] transaction","detail":"{read_only:false; response_revision:24846; number_of_response:1; }","duration":"252.029261ms","start":"2026-06-08T04:22:43.169055Z","end":"2026-06-08T04:22:43.421084Z","steps":["trace[1707949460] 'process raft request' (duration: 251.204605ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:43.421552Z","caller":"traceutil/trace.go:171","msg":"trace[12246767] transaction","detail":"{read_only:false; response_revision:24847; number_of_response:1; }","duration":"252.391418ms","start":"2026-06-08T04:22:43.169143Z","end":"2026-06-08T04:22:43.421535Z","steps":["trace[12246767] 'process raft request' (duration: 251.817417ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:43.42168Z","caller":"traceutil/trace.go:171","msg":"trace[1077967316] transaction","detail":"{read_only:false; response_revision:24848; number_of_response:1; }","duration":"252.369238ms","start":"2026-06-08T04:22:43.169279Z","end":"2026-06-08T04:22:43.421649Z","steps":["trace[1077967316] 'process raft request' (duration: 252.097162ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:43.69729Z","caller":"traceutil/trace.go:171","msg":"trace[2130625984] transaction","detail":"{read_only:false; response_revision:24851; number_of_response:1; }","duration":"213.190662ms","start":"2026-06-08T04:22:43.484071Z","end":"2026-06-08T04:22:43.697262Z","steps":["trace[2130625984] 'process raft request' (duration: 212.960267ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:43.697664Z","caller":"traceutil/trace.go:171","msg":"trace[2018402540] transaction","detail":"{read_only:false; response_revision:24852; number_of_response:1; }","duration":"212.967287ms","start":"2026-06-08T04:22:43.484656Z","end":"2026-06-08T04:22:43.697623Z","steps":["trace[2018402540] 'process raft request' (duration: 212.552277ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:43.697906Z","caller":"traceutil/trace.go:171","msg":"trace[1332317902] transaction","detail":"{read_only:false; response_revision:24853; number_of_response:1; }","duration":"212.873976ms","start":"2026-06-08T04:22:43.484986Z","end":"2026-06-08T04:22:43.69786Z","steps":["trace[1332317902] 'process raft request' (duration: 212.530639ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:43.743017Z","caller":"traceutil/trace.go:171","msg":"trace[170828028] linearizableReadLoop","detail":"{readStateIndex:25669; appliedIndex:25665; }","duration":"214.315155ms","start":"2026-06-08T04:22:43.528671Z","end":"2026-06-08T04:22:43.742986Z","steps":["trace[170828028] 'read index received' (duration: 168.417072ms)","trace[170828028] 'applied index is now lower than readState.Index' (duration: 45.896913ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:43.743069Z","caller":"traceutil/trace.go:171","msg":"trace[861404741] transaction","detail":"{read_only:false; response_revision:24854; number_of_response:1; }","duration":"238.318102ms","start":"2026-06-08T04:22:43.504702Z","end":"2026-06-08T04:22:43.74302Z","steps":["trace[861404741] 'process raft request' (duration: 238.115488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:43.743232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.54635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:22:43.74333Z","caller":"traceutil/trace.go:171","msg":"trace[390797931] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24854; }","duration":"214.701613ms","start":"2026-06-08T04:22:43.528602Z","end":"2026-06-08T04:22:43.743304Z","steps":["trace[390797931] 'agreement among raft nodes before linearized reading' (duration: 214.513719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:43.975075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.323595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-08T04:22:43.975209Z","caller":"traceutil/trace.go:171","msg":"trace[322282543] linearizableReadLoop","detail":"{readStateIndex:25670; appliedIndex:25669; }","duration":"228.248369ms","start":"2026-06-08T04:22:43.746939Z","end":"2026-06-08T04:22:43.975188Z","steps":["trace[322282543] 'read index received' (duration: 81.594618ms)","trace[322282543] 'applied index is now lower than readState.Index' (duration: 146.652011ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:43.975241Z","caller":"traceutil/trace.go:171","msg":"trace[925359947] transaction","detail":"{read_only:false; response_revision:24855; number_of_response:1; }","duration":"228.883901ms","start":"2026-06-08T04:22:43.746322Z","end":"2026-06-08T04:22:43.975206Z","steps":["trace[925359947] 'process raft request' (duration: 82.296122ms)","trace[925359947] 'compare' (duration: 146.089428ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:22:43.975344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.413282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:22:43.975375Z","caller":"traceutil/trace.go:171","msg":"trace[883989309] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24855; }","duration":"228.482513ms","start":"2026-06-08T04:22:43.746879Z","end":"2026-06-08T04:22:43.975362Z","steps":["trace[883989309] 'agreement among raft nodes before linearized reading' (duration: 228.417562ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:45.037103Z","caller":"traceutil/trace.go:171","msg":"trace[1743057704] transaction","detail":"{read_only:false; response_revision:24857; number_of_response:1; }","duration":"398.294903ms","start":"2026-06-08T04:22:44.638783Z","end":"2026-06-08T04:22:45.037078Z","steps":["trace[1743057704] 'process raft request' (duration: 398.095829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:45.037259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:44.638757Z","time spent":"398.421215ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:45.055616Z","caller":"traceutil/trace.go:171","msg":"trace[355801295] linearizableReadLoop","detail":"{readStateIndex:25673; appliedIndex:25671; }","duration":"119.701692ms","start":"2026-06-08T04:22:44.93589Z","end":"2026-06-08T04:22:45.055591Z","steps":["trace[355801295] 'read index received' (duration: 101.064013ms)","trace[355801295] 'applied index is now lower than readState.Index' (duration: 18.636709ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:22:45.05575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.836204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:22:45.055786Z","caller":"traceutil/trace.go:171","msg":"trace[522808825] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:24858; }","duration":"119.918786ms","start":"2026-06-08T04:22:44.935854Z","end":"2026-06-08T04:22:45.055773Z","steps":["trace[522808825] 'agreement among raft nodes before linearized reading' (duration: 119.837245ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:45.0558Z","caller":"traceutil/trace.go:171","msg":"trace[2024739495] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"141.163218ms","start":"2026-06-08T04:22:44.914578Z","end":"2026-06-08T04:22:45.055741Z","steps":["trace[2024739495] 'process raft request' (duration: 140.893812ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:53.690555Z","caller":"traceutil/trace.go:171","msg":"trace[1574822386] transaction","detail":"{read_only:false; response_revision:24920; number_of_response:1; }","duration":"240.601815ms","start":"2026-06-08T04:22:53.449932Z","end":"2026-06-08T04:22:53.690534Z","steps":["trace[1574822386] 'process raft request' (duration: 238.816319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.274804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.668208ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-08T04:22:54.275008Z","caller":"traceutil/trace.go:171","msg":"trace[1320819547] transaction","detail":"{read_only:false; response_revision:24921; number_of_response:1; }","duration":"822.238523ms","start":"2026-06-08T04:22:53.452749Z","end":"2026-06-08T04:22:54.274988Z","steps":["trace[1320819547] 'process raft request' (duration: 345.2864ms)","trace[1320819547] 'compare' (duration: 476.234138ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:22:54.275077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.452742Z","time spent":"822.305884ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:54.275585Z","caller":"traceutil/trace.go:171","msg":"trace[498458172] transaction","detail":"{read_only:false; response_revision:24922; number_of_response:1; }","duration":"821.405307ms","start":"2026-06-08T04:22:53.454157Z","end":"2026-06-08T04:22:54.275562Z","steps":["trace[498458172] 'process raft request' (duration: 820.748813ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:54.275611Z","caller":"traceutil/trace.go:171","msg":"trace[1088391441] transaction","detail":"{read_only:false; response_revision:24925; number_of_response:1; }","duration":"102.753536ms","start":"2026-06-08T04:22:54.172824Z","end":"2026-06-08T04:22:54.275578Z","steps":["trace[1088391441] 'process raft request' (duration: 102.683275ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:54.275612Z","caller":"traceutil/trace.go:171","msg":"trace[1912661690] linearizableReadLoop","detail":"{readStateIndex:25740; appliedIndex:25736; }","duration":"775.494345ms","start":"2026-06-08T04:22:53.50007Z","end":"2026-06-08T04:22:54.275565Z","steps":["trace[1912661690] 'read index received' (duration: 188.697681ms)","trace[1912661690] 'applied index is now lower than readState.Index' (duration: 586.792924ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:22:54.275693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.454139Z","time spent":"821.50851ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:54.275613Z","caller":"traceutil/trace.go:171","msg":"trace[843212821] transaction","detail":"{read_only:false; response_revision:24923; number_of_response:1; }","duration":"818.14058ms","start":"2026-06-08T04:22:53.457432Z","end":"2026-06-08T04:22:54.275573Z","steps":["trace[843212821] 'process raft request' (duration: 817.897624ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:54.2757Z","caller":"traceutil/trace.go:171","msg":"trace[1993366332] transaction","detail":"{read_only:false; response_revision:24924; number_of_response:1; }","duration":"499.858589ms","start":"2026-06-08T04:22:53.7758Z","end":"2026-06-08T04:22:54.275659Z","steps":["trace[1993366332] 'process raft request' (duration: 499.640555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.275921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.818421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-08T04:22:54.275976Z","caller":"traceutil/trace.go:171","msg":"trace[1821393211] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:24925; }","duration":"775.936714ms","start":"2026-06-08T04:22:53.500028Z","end":"2026-06-08T04:22:54.275965Z","steps":["trace[1821393211] 'agreement among raft nodes before linearized reading' (duration: 775.74245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.276012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.775777Z","time spent":"500.114665ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:22:54.276026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.787308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-06-08T04:22:54.27599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.457426Z","time spent":"818.382055ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:54.276078Z","caller":"traceutil/trace.go:171","msg":"trace[535693670] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24925; }","duration":"535.87923ms","start":"2026-06-08T04:22:53.740184Z","end":"2026-06-08T04:22:54.276063Z","steps":["trace[535693670] 'agreement among raft nodes before linearized reading' (duration: 535.721397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.276139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.740159Z","time spent":"535.972962ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T04:22:54.276004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.078243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-08T04:22:54.276157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.625455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-08T04:22:54.27613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.532534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-08T04:22:54.276196Z","caller":"traceutil/trace.go:171","msg":"trace[1527467668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24925; }","duration":"533.299017ms","start":"2026-06-08T04:22:53.742884Z","end":"2026-06-08T04:22:54.276183Z","steps":["trace[1527467668] 'agreement among raft nodes before linearized reading' (duration: 532.983941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.2761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.290769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-08T04:22:54.276234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.742879Z","time spent":"533.344828ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-08T04:22:54.276233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.125094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:22:54.276233Z","caller":"traceutil/trace.go:171","msg":"trace[1748433442] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24925; }","duration":"769.687547ms","start":"2026-06-08T04:22:53.506528Z","end":"2026-06-08T04:22:54.276216Z","steps":["trace[1748433442] 'agreement among raft nodes before linearized reading' (duration: 769.31855ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:54.27628Z","caller":"traceutil/trace.go:171","msg":"trace[215261447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24925; }","duration":"301.164805ms","start":"2026-06-08T04:22:53.975102Z","end":"2026-06-08T04:22:54.276266Z","steps":["trace[215261447] 'agreement among raft nodes before linearized reading' (duration: 301.109054ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.276188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.402344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"} {"level":"warn","ts":"2026-06-08T04:22:54.276314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.974936Z","time spent":"301.371399ms","remote":"127.0.0.1:38174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-08T04:22:54.276258Z","caller":"traceutil/trace.go:171","msg":"trace[970167619] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:24925; }","duration":"146.487843ms","start":"2026-06-08T04:22:54.129751Z","end":"2026-06-08T04:22:54.276239Z","steps":["trace[970167619] 'agreement among raft nodes before linearized reading' (duration: 146.31048ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:54.276375Z","caller":"traceutil/trace.go:171","msg":"trace[90913409] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24925; }","duration":"184.579028ms","start":"2026-06-08T04:22:54.091733Z","end":"2026-06-08T04:22:54.276312Z","steps":["trace[90913409] 'agreement among raft nodes before linearized reading' (duration: 184.390754ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.276318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.506508Z","time spent":"769.796969ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-08T04:22:54.276026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.500009Z","time spent":"776.006395ms","remote":"127.0.0.1:38610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":60,"response size":32,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-06-08T04:22:54.276197Z","caller":"traceutil/trace.go:171","msg":"trace[798515699] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24925; }","duration":"732.681975ms","start":"2026-06-08T04:22:53.543502Z","end":"2026-06-08T04:22:54.276184Z","steps":["trace[798515699] 'agreement among raft nodes before linearized reading' (duration: 732.562923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.27617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.465821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-08T04:22:54.27687Z","caller":"traceutil/trace.go:171","msg":"trace[10669035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24925; }","duration":"536.192226ms","start":"2026-06-08T04:22:53.740665Z","end":"2026-06-08T04:22:54.276857Z","steps":["trace[10669035] 'agreement among raft nodes before linearized reading' (duration: 535.362909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.276944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.740653Z","time spent":"536.249637ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-08T04:22:54.276944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.543492Z","time spent":"733.365899ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-08T04:22:54.277013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.699342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-06-08T04:22:54.277192Z","caller":"traceutil/trace.go:171","msg":"trace[429573300] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:24925; }","duration":"756.014259ms","start":"2026-06-08T04:22:53.521114Z","end":"2026-06-08T04:22:54.277128Z","steps":["trace[429573300] 'agreement among raft nodes before linearized reading' (duration: 755.094891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.27735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:53.521105Z","time spent":"756.184512ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1890,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-08T04:22:54.608951Z","caller":"traceutil/trace.go:171","msg":"trace[2019597665] linearizableReadLoop","detail":"{readStateIndex:25744; appliedIndex:25742; }","duration":"325.988638ms","start":"2026-06-08T04:22:54.282913Z","end":"2026-06-08T04:22:54.608902Z","steps":["trace[2019597665] 'read index received' (duration: 5.593293ms)","trace[2019597665] 'applied index is now lower than readState.Index' (duration: 320.394415ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:22:54.609214Z","caller":"traceutil/trace.go:171","msg":"trace[1095145463] transaction","detail":"{read_only:false; response_revision:24927; number_of_response:1; }","duration":"326.331185ms","start":"2026-06-08T04:22:54.28287Z","end":"2026-06-08T04:22:54.609201Z","steps":["trace[1095145463] 'process raft request' (duration: 325.678351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.609353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:54.282854Z","time spent":"326.400287ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:54.609547Z","caller":"traceutil/trace.go:171","msg":"trace[1413188326] transaction","detail":"{read_only:false; response_revision:24928; number_of_response:1; }","duration":"326.508949ms","start":"2026-06-08T04:22:54.282994Z","end":"2026-06-08T04:22:54.609503Z","steps":["trace[1413188326] 'process raft request' (duration: 325.755734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.609586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:54.282975Z","time spent":"326.591491ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:54.609678Z","caller":"traceutil/trace.go:171","msg":"trace[835958391] transaction","detail":"{read_only:false; response_revision:24929; number_of_response:1; }","duration":"326.105211ms","start":"2026-06-08T04:22:54.283567Z","end":"2026-06-08T04:22:54.609672Z","steps":["trace[835958391] 'process raft request' (duration: 325.254004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.609716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:54.283559Z","time spent":"326.140031ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:22:54.609924Z","caller":"traceutil/trace.go:171","msg":"trace[689239264] transaction","detail":"{read_only:false; response_revision:24930; number_of_response:1; }","duration":"326.292485ms","start":"2026-06-08T04:22:54.283623Z","end":"2026-06-08T04:22:54.609915Z","steps":["trace[689239264] 'process raft request' (duration: 325.239154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.610174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.244704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18541"} {"level":"info","ts":"2026-06-08T04:22:54.610245Z","caller":"traceutil/trace.go:171","msg":"trace[2097187651] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24930; }","duration":"327.360486ms","start":"2026-06-08T04:22:54.282872Z","end":"2026-06-08T04:22:54.610232Z","steps":["trace[2097187651] 'agreement among raft nodes before linearized reading' (duration: 327.129401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.610278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:54.282831Z","time spent":"327.441568ms","remote":"127.0.0.1:38344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18565,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-08T04:22:54.610275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.768574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:22:54.610384Z","caller":"traceutil/trace.go:171","msg":"trace[1584817836] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:24930; }","duration":"291.941057ms","start":"2026-06-08T04:22:54.318414Z","end":"2026-06-08T04:22:54.610355Z","steps":["trace[1584817836] 'agreement among raft nodes before linearized reading' (duration: 291.732502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:54.610924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:54.283617Z","time spent":"326.330925ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:22:55.211255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.933581ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:22:55.213788Z","caller":"traceutil/trace.go:171","msg":"trace[481024059] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24930; }","duration":"438.493882ms","start":"2026-06-08T04:22:54.775275Z","end":"2026-06-08T04:22:55.213769Z","steps":["trace[481024059] 'range keys from in-memory index tree' (duration: 435.91685ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:55.221769Z","caller":"traceutil/trace.go:171","msg":"trace[775074335] transaction","detail":"{read_only:false; response_revision:24931; number_of_response:1; }","duration":"112.217249ms","start":"2026-06-08T04:22:55.109516Z","end":"2026-06-08T04:22:55.221733Z","steps":["trace[775074335] 'process raft request' (duration: 111.76077ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:22:55.467123Z","caller":"traceutil/trace.go:171","msg":"trace[852431432] transaction","detail":"{read_only:false; response_revision:24932; number_of_response:1; }","duration":"319.708421ms","start":"2026-06-08T04:22:55.14736Z","end":"2026-06-08T04:22:55.467068Z","steps":["trace[852431432] 'process raft request' (duration: 319.450506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:22:55.467396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:22:55.147332Z","time spent":"319.918084ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:23:02.043767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.081472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b73cc9f2-32b9-4b79-9e91-20dffa4d9eb2\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-06-08T04:23:02.043853Z","caller":"traceutil/trace.go:171","msg":"trace[859433140] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b73cc9f2-32b9-4b79-9e91-20dffa4d9eb2; range_end:; response_count:1; response_revision:25039; }","duration":"131.228895ms","start":"2026-06-08T04:23:01.912602Z","end":"2026-06-08T04:23:02.043831Z","steps":["trace[859433140] 'range keys from in-memory index tree' (duration: 130.911739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:02.32553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.792403ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-08T04:23:02.469376Z","caller":"traceutil/trace.go:171","msg":"trace[1106706928] transaction","detail":"{read_only:false; response_revision:25040; number_of_response:1; }","duration":"165.433839ms","start":"2026-06-08T04:23:02.303925Z","end":"2026-06-08T04:23:02.469359Z","steps":["trace[1106706928] 'process raft request' (duration: 165.303416ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:02.605032Z","caller":"traceutil/trace.go:171","msg":"trace[1462968155] transaction","detail":"{read_only:false; response_revision:25041; number_of_response:1; }","duration":"291.556739ms","start":"2026-06-08T04:23:02.313447Z","end":"2026-06-08T04:23:02.605004Z","steps":["trace[1462968155] 'process raft request' (duration: 289.868395ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:02.605307Z","caller":"traceutil/trace.go:171","msg":"trace[743278796] linearizableReadLoop","detail":"{readStateIndex:25863; appliedIndex:25858; }","duration":"279.689828ms","start":"2026-06-08T04:23:02.3256Z","end":"2026-06-08T04:23:02.60529Z","steps":["trace[743278796] 'read index received' (duration: 143.629025ms)","trace[743278796] 'applied index is now lower than readState.Index' (duration: 136.059633ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:02.605308Z","caller":"traceutil/trace.go:171","msg":"trace[2071468992] transaction","detail":"{read_only:false; response_revision:25042; number_of_response:1; }","duration":"291.769113ms","start":"2026-06-08T04:23:02.313509Z","end":"2026-06-08T04:23:02.605279Z","steps":["trace[2071468992] 'process raft request' (duration: 291.446016ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:02.605357Z","caller":"traceutil/trace.go:171","msg":"trace[296403572] transaction","detail":"{read_only:false; response_revision:25044; number_of_response:1; }","duration":"291.791734ms","start":"2026-06-08T04:23:02.313546Z","end":"2026-06-08T04:23:02.605338Z","steps":["trace[296403572] 'process raft request' (duration: 291.689832ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:02.60539Z","caller":"traceutil/trace.go:171","msg":"trace[824415463] transaction","detail":"{read_only:false; response_revision:25043; number_of_response:1; }","duration":"291.827095ms","start":"2026-06-08T04:23:02.313506Z","end":"2026-06-08T04:23:02.605333Z","steps":["trace[824415463] 'process raft request' (duration: 291.628871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:02.605649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.684312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-08T04:23:02.605689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.902221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"warn","ts":"2026-06-08T04:23:02.605674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.205361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-08T04:23:02.605761Z","caller":"traceutil/trace.go:171","msg":"trace[815417955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25044; }","duration":"288.324284ms","start":"2026-06-08T04:23:02.317418Z","end":"2026-06-08T04:23:02.605742Z","steps":["trace[815417955] 'agreement among raft nodes before linearized reading' (duration: 287.990778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:02.605777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.489636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b73cc9f2-32b9-4b79-9e91-20dffa4d9eb2\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-06-08T04:23:02.605819Z","caller":"traceutil/trace.go:171","msg":"trace[300530139] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b73cc9f2-32b9-4b79-9e91-20dffa4d9eb2; range_end:; response_count:1; response_revision:25044; }","duration":"153.570878ms","start":"2026-06-08T04:23:02.452234Z","end":"2026-06-08T04:23:02.605805Z","steps":["trace[300530139] 'agreement among raft nodes before linearized reading' (duration: 153.389665ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:02.60572Z","caller":"traceutil/trace.go:171","msg":"trace[602983433] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:25044; }","duration":"141.954063ms","start":"2026-06-08T04:23:02.463756Z","end":"2026-06-08T04:23:02.60571Z","steps":["trace[602983433] 'agreement among raft nodes before linearized reading' (duration: 141.82524ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:02.60571Z","caller":"traceutil/trace.go:171","msg":"trace[805771550] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:25044; }","duration":"225.796933ms","start":"2026-06-08T04:23:02.379897Z","end":"2026-06-08T04:23:02.605694Z","steps":["trace[805771550] 'agreement among raft nodes before linearized reading' (duration: 225.682671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:02.606002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.976997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:23:02.60603Z","caller":"traceutil/trace.go:171","msg":"trace[377058191] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0; response_count:0; response_revision:25044; }","duration":"161.008048ms","start":"2026-06-08T04:23:02.445014Z","end":"2026-06-08T04:23:02.606022Z","steps":["trace[377058191] 'agreement among raft nodes before linearized reading' (duration: 160.965187ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:02.803887Z","caller":"traceutil/trace.go:171","msg":"trace[922761206] transaction","detail":"{read_only:false; response_revision:25045; number_of_response:1; }","duration":"191.695582ms","start":"2026-06-08T04:23:02.612146Z","end":"2026-06-08T04:23:02.803842Z","steps":["trace[922761206] 'process raft request' (duration: 108.116735ms)","trace[922761206] 'compare' (duration: 83.381524ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:02.983361Z","caller":"traceutil/trace.go:171","msg":"trace[775768225] linearizableReadLoop","detail":"{readStateIndex:25865; appliedIndex:25863; }","duration":"337.130654ms","start":"2026-06-08T04:23:02.646203Z","end":"2026-06-08T04:23:02.983334Z","steps":["trace[775768225] 'read index received' (duration: 74.013692ms)","trace[775768225] 'applied index is now lower than readState.Index' (duration: 263.115872ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:02.983488Z","caller":"traceutil/trace.go:171","msg":"trace[1574917711] transaction","detail":"{read_only:false; response_revision:25046; number_of_response:1; }","duration":"371.257988ms","start":"2026-06-08T04:23:02.612189Z","end":"2026-06-08T04:23:02.983447Z","steps":["trace[1574917711] 'process raft request' (duration: 330.744186ms)","trace[1574917711] 'compare' (duration: 40.260067ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:23:02.983671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:02.612179Z","time spent":"371.40535ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:23:02.983802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.580483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-06-08T04:23:02.983839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.195755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-08T04:23:02.983886Z","caller":"traceutil/trace.go:171","msg":"trace[380671984] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25046; }","duration":"337.709346ms","start":"2026-06-08T04:23:02.646163Z","end":"2026-06-08T04:23:02.983872Z","steps":["trace[380671984] 'agreement among raft nodes before linearized reading' (duration: 337.367139ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:02.98391Z","caller":"traceutil/trace.go:171","msg":"trace[624661566] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25046; }","duration":"337.289687ms","start":"2026-06-08T04:23:02.646602Z","end":"2026-06-08T04:23:02.983892Z","steps":["trace[624661566] 'agreement among raft nodes before linearized reading' (duration: 337.101414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:02.983949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:02.646595Z","time spent":"337.347078ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-08T04:23:02.983954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:02.64615Z","time spent":"337.792197ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T04:23:02.98408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.380657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-08T04:23:02.984115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.873898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-08T04:23:02.984141Z","caller":"traceutil/trace.go:171","msg":"trace[443053565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25046; }","duration":"331.944348ms","start":"2026-06-08T04:23:02.652188Z","end":"2026-06-08T04:23:02.984133Z","steps":["trace[443053565] 'agreement among raft nodes before linearized reading' (duration: 331.854526ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:02.984139Z","caller":"traceutil/trace.go:171","msg":"trace[1021735071] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25046; }","duration":"327.460858ms","start":"2026-06-08T04:23:02.656663Z","end":"2026-06-08T04:23:02.984124Z","steps":["trace[1021735071] 'agreement among raft nodes before linearized reading' (duration: 327.309815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:02.984166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:02.652171Z","time spent":"331.98981ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-08T04:23:02.984175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:02.656655Z","time spent":"327.513249ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-08T04:23:02.98434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.884032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:23:02.984457Z","caller":"traceutil/trace.go:171","msg":"trace[501296821] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:25046; }","duration":"112.024824ms","start":"2026-06-08T04:23:02.872411Z","end":"2026-06-08T04:23:02.984436Z","steps":["trace[501296821] 'agreement among raft nodes before linearized reading' (duration: 111.379191ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:03.110821Z","caller":"traceutil/trace.go:171","msg":"trace[369167878] transaction","detail":"{read_only:false; response_revision:25047; number_of_response:1; }","duration":"122.090158ms","start":"2026-06-08T04:23:02.988684Z","end":"2026-06-08T04:23:03.110774Z","steps":["trace[369167878] 'process raft request' (duration: 105.013342ms)","trace[369167878] 'compare' (duration: 16.854132ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:03.116592Z","caller":"traceutil/trace.go:171","msg":"trace[722182299] transaction","detail":"{read_only:false; response_revision:25048; number_of_response:1; }","duration":"127.319906ms","start":"2026-06-08T04:23:02.989231Z","end":"2026-06-08T04:23:03.116551Z","steps":["trace[722182299] 'process raft request' (duration: 127.07176ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:03.11696Z","caller":"traceutil/trace.go:171","msg":"trace[438309050] transaction","detail":"{read_only:false; response_revision:25049; number_of_response:1; }","duration":"127.641782ms","start":"2026-06-08T04:23:02.989256Z","end":"2026-06-08T04:23:03.116898Z","steps":["trace[438309050] 'process raft request' (duration: 127.218892ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:03.117222Z","caller":"traceutil/trace.go:171","msg":"trace[251495874] transaction","detail":"{read_only:false; response_revision:25050; number_of_response:1; }","duration":"126.318885ms","start":"2026-06-08T04:23:02.990884Z","end":"2026-06-08T04:23:03.117203Z","steps":["trace[251495874] 'process raft request' (duration: 125.875766ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:03.117679Z","caller":"traceutil/trace.go:171","msg":"trace[1475839172] linearizableReadLoop","detail":"{readStateIndex:25868; appliedIndex:25865; }","duration":"127.51735ms","start":"2026-06-08T04:23:02.99014Z","end":"2026-06-08T04:23:03.117658Z","steps":["trace[1475839172] 'read index received' (duration: 103.791547ms)","trace[1475839172] 'applied index is now lower than readState.Index' (duration: 23.723643ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:03.117867Z","caller":"traceutil/trace.go:171","msg":"trace[1122751322] transaction","detail":"{read_only:false; response_revision:25051; number_of_response:1; }","duration":"101.46228ms","start":"2026-06-08T04:23:03.016392Z","end":"2026-06-08T04:23:03.117854Z","steps":["trace[1122751322] 'process raft request' (duration: 100.762126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:03.118153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.996679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:23:03.118199Z","caller":"traceutil/trace.go:171","msg":"trace[816557519] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/flavors/; range_end:/registry/openstack.k-orc.cloud/flavors0; response_count:0; response_revision:25051; }","duration":"128.095781ms","start":"2026-06-08T04:23:02.990092Z","end":"2026-06-08T04:23:03.118188Z","steps":["trace[816557519] 'agreement among raft nodes before linearized reading' (duration: 128.008899ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:04.806318Z","caller":"traceutil/trace.go:171","msg":"trace[966316896] transaction","detail":"{read_only:false; response_revision:25058; number_of_response:1; }","duration":"195.00767ms","start":"2026-06-08T04:23:04.611281Z","end":"2026-06-08T04:23:04.806288Z","steps":["trace[966316896] 'process raft request' (duration: 194.808446ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:04.806856Z","caller":"traceutil/trace.go:171","msg":"trace[1072219316] transaction","detail":"{read_only:false; response_revision:25059; number_of_response:1; }","duration":"194.228973ms","start":"2026-06-08T04:23:04.612612Z","end":"2026-06-08T04:23:04.806841Z","steps":["trace[1072219316] 'process raft request' (duration: 194.110351ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:04.806971Z","caller":"traceutil/trace.go:171","msg":"trace[1509465352] transaction","detail":"{read_only:false; response_revision:25060; number_of_response:1; }","duration":"193.797654ms","start":"2026-06-08T04:23:04.613157Z","end":"2026-06-08T04:23:04.806955Z","steps":["trace[1509465352] 'process raft request' (duration: 193.637421ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:04.80706Z","caller":"traceutil/trace.go:171","msg":"trace[2031435290] transaction","detail":"{read_only:false; response_revision:25061; number_of_response:1; }","duration":"191.332414ms","start":"2026-06-08T04:23:04.615703Z","end":"2026-06-08T04:23:04.807036Z","steps":["trace[2031435290] 'process raft request' (duration: 191.196991ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:08.662179Z","caller":"traceutil/trace.go:171","msg":"trace[332298492] transaction","detail":"{read_only:false; response_revision:25105; number_of_response:1; }","duration":"169.225356ms","start":"2026-06-08T04:23:08.492933Z","end":"2026-06-08T04:23:08.662158Z","steps":["trace[332298492] 'process raft request' (duration: 168.730046ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:09.319003Z","caller":"traceutil/trace.go:171","msg":"trace[955619883] transaction","detail":"{read_only:false; response_revision:25120; number_of_response:1; }","duration":"104.312509ms","start":"2026-06-08T04:23:09.214662Z","end":"2026-06-08T04:23:09.318975Z","steps":["trace[955619883] 'process raft request' (duration: 104.124555ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:33.697835Z","caller":"traceutil/trace.go:171","msg":"trace[1531899852] transaction","detail":"{read_only:false; response_revision:25314; number_of_response:1; }","duration":"169.610072ms","start":"2026-06-08T04:23:33.528187Z","end":"2026-06-08T04:23:33.697797Z","steps":["trace[1531899852] 'process raft request' (duration: 169.367327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:35.245265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.601182ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-08T04:23:35.24542Z","caller":"traceutil/trace.go:171","msg":"trace[1641095255] linearizableReadLoop","detail":"{readStateIndex:26147; appliedIndex:26144; }","duration":"129.920198ms","start":"2026-06-08T04:23:35.115487Z","end":"2026-06-08T04:23:35.245407Z","steps":["trace[1641095255] 'read index received' (duration: 70.434079ms)","trace[1641095255] 'applied index is now lower than readState.Index' (duration: 59.485389ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:23:35.245606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.128693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:23:35.245636Z","caller":"traceutil/trace.go:171","msg":"trace[521085432] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:25321; }","duration":"130.219524ms","start":"2026-06-08T04:23:35.115409Z","end":"2026-06-08T04:23:35.245629Z","steps":["trace[521085432] 'agreement among raft nodes before linearized reading' (duration: 130.168963ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:35.245656Z","caller":"traceutil/trace.go:171","msg":"trace[1851531026] transaction","detail":"{read_only:false; response_revision:25319; number_of_response:1; }","duration":"260.168343ms","start":"2026-06-08T04:23:34.985473Z","end":"2026-06-08T04:23:35.245641Z","steps":["trace[1851531026] 'process raft request' (duration: 126.116291ms)","trace[1851531026] 'compare' (duration: 133.49965ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:35.245554Z","caller":"traceutil/trace.go:171","msg":"trace[660239863] transaction","detail":"{read_only:false; response_revision:25320; number_of_response:1; }","duration":"258.887167ms","start":"2026-06-08T04:23:34.986617Z","end":"2026-06-08T04:23:35.245504Z","steps":["trace[660239863] 'process raft request' (duration: 258.735373ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:35.246166Z","caller":"traceutil/trace.go:171","msg":"trace[1794344249] transaction","detail":"{read_only:false; response_revision:25321; number_of_response:1; }","duration":"257.977559ms","start":"2026-06-08T04:23:34.987621Z","end":"2026-06-08T04:23:35.245598Z","steps":["trace[1794344249] 'process raft request' (duration: 257.759554ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:35.462222Z","caller":"traceutil/trace.go:171","msg":"trace[1452929575] linearizableReadLoop","detail":"{readStateIndex:26150; appliedIndex:26148; }","duration":"172.901431ms","start":"2026-06-08T04:23:35.289304Z","end":"2026-06-08T04:23:35.462206Z","steps":["trace[1452929575] 'read index received' (duration: 41.079765ms)","trace[1452929575] 'applied index is now lower than readState.Index' (duration: 131.821086ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:35.462294Z","caller":"traceutil/trace.go:171","msg":"trace[1762527616] transaction","detail":"{read_only:false; response_revision:25324; number_of_response:1; }","duration":"179.009755ms","start":"2026-06-08T04:23:35.283274Z","end":"2026-06-08T04:23:35.462284Z","steps":["trace[1762527616] 'process raft request' (duration: 105.103104ms)","trace[1762527616] 'compare' (duration: 73.737867ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:23:35.462502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.191147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-08T04:23:35.462526Z","caller":"traceutil/trace.go:171","msg":"trace[1174671308] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25324; }","duration":"173.254427ms","start":"2026-06-08T04:23:35.289266Z","end":"2026-06-08T04:23:35.46252Z","steps":["trace[1174671308] 'agreement among raft nodes before linearized reading' (duration: 173.146915ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:35.625345Z","caller":"traceutil/trace.go:171","msg":"trace[1820081474] transaction","detail":"{read_only:false; response_revision:25325; number_of_response:1; }","duration":"166.344287ms","start":"2026-06-08T04:23:35.458956Z","end":"2026-06-08T04:23:35.6253Z","steps":["trace[1820081474] 'process raft request' (duration: 117.008106ms)","trace[1820081474] 'compare' (duration: 49.095926ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:35.625397Z","caller":"traceutil/trace.go:171","msg":"trace[89097512] transaction","detail":"{read_only:false; response_revision:25326; number_of_response:1; }","duration":"159.610571ms","start":"2026-06-08T04:23:35.465767Z","end":"2026-06-08T04:23:35.625378Z","steps":["trace[89097512] 'process raft request' (duration: 159.474898ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:35.625426Z","caller":"traceutil/trace.go:171","msg":"trace[460637558] linearizableReadLoop","detail":"{readStateIndex:26151; appliedIndex:26150; }","duration":"163.104441ms","start":"2026-06-08T04:23:35.462265Z","end":"2026-06-08T04:23:35.625369Z","steps":["trace[460637558] 'read index received' (duration: 113.716709ms)","trace[460637558] 'applied index is now lower than readState.Index' (duration: 49.384462ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:23:35.625737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.244634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"} {"level":"info","ts":"2026-06-08T04:23:35.625811Z","caller":"traceutil/trace.go:171","msg":"trace[1496099400] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25327; }","duration":"260.374726ms","start":"2026-06-08T04:23:35.365421Z","end":"2026-06-08T04:23:35.625796Z","steps":["trace[1496099400] 'agreement among raft nodes before linearized reading' (duration: 260.139771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:35.625849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.802525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-08T04:23:35.625908Z","caller":"traceutil/trace.go:171","msg":"trace[1472270952] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25327; }","duration":"328.910707ms","start":"2026-06-08T04:23:35.296977Z","end":"2026-06-08T04:23:35.625888Z","steps":["trace[1472270952] 'agreement among raft nodes before linearized reading' (duration: 328.635801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:35.625958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:35.296961Z","time spent":"328.986449ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-08T04:23:35.626032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.796425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-08T04:23:35.626172Z","caller":"traceutil/trace.go:171","msg":"trace[1351829885] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:25327; }","duration":"163.02256ms","start":"2026-06-08T04:23:35.463123Z","end":"2026-06-08T04:23:35.626145Z","steps":["trace[1351829885] 'agreement among raft nodes before linearized reading' (duration: 162.805706ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:35.843428Z","caller":"traceutil/trace.go:171","msg":"trace[376354327] transaction","detail":"{read_only:false; response_revision:25330; number_of_response:1; }","duration":"118.7545ms","start":"2026-06-08T04:23:35.724652Z","end":"2026-06-08T04:23:35.843407Z","steps":["trace[376354327] 'process raft request' (duration: 118.471185ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:37.187218Z","caller":"traceutil/trace.go:171","msg":"trace[1458629715] transaction","detail":"{read_only:false; response_revision:25335; number_of_response:1; }","duration":"207.015612ms","start":"2026-06-08T04:23:36.980168Z","end":"2026-06-08T04:23:37.187184Z","steps":["trace[1458629715] 'process raft request' (duration: 124.517387ms)","trace[1458629715] 'compare' (duration: 82.334872ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:37.358143Z","caller":"traceutil/trace.go:171","msg":"trace[837359797] transaction","detail":"{read_only:false; response_revision:25337; number_of_response:1; }","duration":"106.460462ms","start":"2026-06-08T04:23:37.25166Z","end":"2026-06-08T04:23:37.35812Z","steps":["trace[837359797] 'process raft request' (duration: 70.616334ms)","trace[837359797] 'compare' (duration: 35.642394ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:37.35834Z","caller":"traceutil/trace.go:171","msg":"trace[180781921] transaction","detail":"{read_only:false; response_revision:25338; number_of_response:1; }","duration":"104.829489ms","start":"2026-06-08T04:23:37.25348Z","end":"2026-06-08T04:23:37.358309Z","steps":["trace[180781921] 'process raft request' (duration: 104.551863ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:41.826662Z","caller":"traceutil/trace.go:171","msg":"trace[578996805] linearizableReadLoop","detail":"{readStateIndex:26198; appliedIndex:26197; }","duration":"122.301464ms","start":"2026-06-08T04:23:41.704323Z","end":"2026-06-08T04:23:41.826624Z","steps":["trace[578996805] 'read index received' (duration: 119.435166ms)","trace[578996805] 'applied index is now lower than readState.Index' (duration: 2.864408ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:41.826726Z","caller":"traceutil/trace.go:171","msg":"trace[1338079943] transaction","detail":"{read_only:false; response_revision:25371; number_of_response:1; }","duration":"132.703935ms","start":"2026-06-08T04:23:41.693987Z","end":"2026-06-08T04:23:41.826691Z","steps":["trace[1338079943] 'process raft request' (duration: 129.735945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:41.827116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.765793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-08T04:23:41.827261Z","caller":"traceutil/trace.go:171","msg":"trace[749863639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25371; }","duration":"122.953217ms","start":"2026-06-08T04:23:41.704254Z","end":"2026-06-08T04:23:41.827207Z","steps":["trace[749863639] 'agreement among raft nodes before linearized reading' (duration: 122.572219ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:47.493091Z","caller":"traceutil/trace.go:171","msg":"trace[2022838799] transaction","detail":"{read_only:false; response_revision:25409; number_of_response:1; }","duration":"101.267707ms","start":"2026-06-08T04:23:47.391798Z","end":"2026-06-08T04:23:47.493066Z","steps":["trace[2022838799] 'process raft request' (duration: 29.738564ms)","trace[2022838799] 'compare' (duration: 70.864949ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:47.527143Z","caller":"traceutil/trace.go:171","msg":"trace[717350465] transaction","detail":"{read_only:false; response_revision:25410; number_of_response:1; }","duration":"132.230434ms","start":"2026-06-08T04:23:47.394892Z","end":"2026-06-08T04:23:47.527123Z","steps":["trace[717350465] 'process raft request' (duration: 132.078651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:47.819863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.076266ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-08T04:23:47.820108Z","caller":"traceutil/trace.go:171","msg":"trace[943549627] linearizableReadLoop","detail":"{readStateIndex:26241; appliedIndex:26239; }","duration":"169.079973ms","start":"2026-06-08T04:23:47.65101Z","end":"2026-06-08T04:23:47.82009Z","steps":["trace[943549627] 'read index received' (duration: 73.077724ms)","trace[943549627] 'applied index is now lower than readState.Index' (duration: 96.001119ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:47.820142Z","caller":"traceutil/trace.go:171","msg":"trace[1886774409] transaction","detail":"{read_only:false; response_revision:25411; number_of_response:1; }","duration":"288.171171ms","start":"2026-06-08T04:23:47.531925Z","end":"2026-06-08T04:23:47.820097Z","steps":["trace[1886774409] 'process raft request' (duration: 74.758898ms)","trace[1886774409] 'compare' (duration: 212.874402ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:47.820212Z","caller":"traceutil/trace.go:171","msg":"trace[1855510159] transaction","detail":"{read_only:false; response_revision:25412; number_of_response:1; }","duration":"286.732791ms","start":"2026-06-08T04:23:47.533468Z","end":"2026-06-08T04:23:47.820201Z","steps":["trace[1855510159] 'process raft request' (duration: 286.524507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:47.820358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.740278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-dhcp-agent-default-xqthn.18b6ffacb6cd88bf\" ","response":"range_response_count:1 size:957"} {"level":"info","ts":"2026-06-08T04:23:47.820416Z","caller":"traceutil/trace.go:171","msg":"trace[853941507] range","detail":"{range_begin:/registry/events/openstack/neutron-dhcp-agent-default-xqthn.18b6ffacb6cd88bf; range_end:; response_count:1; response_revision:25412; }","duration":"142.819289ms","start":"2026-06-08T04:23:47.677582Z","end":"2026-06-08T04:23:47.820402Z","steps":["trace[853941507] 'agreement among raft nodes before linearized reading' (duration: 142.648766ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:47.820391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.361878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-08T04:23:47.820465Z","caller":"traceutil/trace.go:171","msg":"trace[885042175] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25412; }","duration":"169.47051ms","start":"2026-06-08T04:23:47.650977Z","end":"2026-06-08T04:23:47.820447Z","steps":["trace[885042175] 'agreement among raft nodes before linearized reading' (duration: 169.268966ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:48.027085Z","caller":"traceutil/trace.go:171","msg":"trace[500690916] transaction","detail":"{read_only:false; response_revision:25416; number_of_response:1; }","duration":"145.958613ms","start":"2026-06-08T04:23:47.881092Z","end":"2026-06-08T04:23:48.02705Z","steps":["trace[500690916] 'process raft request' (duration: 145.884571ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:48.027128Z","caller":"traceutil/trace.go:171","msg":"trace[1266927114] transaction","detail":"{read_only:false; response_revision:25414; number_of_response:1; }","duration":"201.807007ms","start":"2026-06-08T04:23:47.825286Z","end":"2026-06-08T04:23:48.027093Z","steps":["trace[1266927114] 'process raft request' (duration: 131.827017ms)","trace[1266927114] 'compare' (duration: 69.566482ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:48.027135Z","caller":"traceutil/trace.go:171","msg":"trace[1871986993] transaction","detail":"{read_only:false; response_revision:25415; number_of_response:1; }","duration":"177.081395ms","start":"2026-06-08T04:23:47.850022Z","end":"2026-06-08T04:23:48.027104Z","steps":["trace[1871986993] 'process raft request' (duration: 176.87428ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:48.027282Z","caller":"traceutil/trace.go:171","msg":"trace[2146698797] linearizableReadLoop","detail":"{readStateIndex:26244; appliedIndex:26241; }","duration":"173.166796ms","start":"2026-06-08T04:23:47.854101Z","end":"2026-06-08T04:23:48.027268Z","steps":["trace[2146698797] 'read index received' (duration: 5.308028ms)","trace[2146698797] 'applied index is now lower than readState.Index' (duration: 167.857898ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:23:48.027492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.858878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-08T04:23:48.027541Z","caller":"traceutil/trace.go:171","msg":"trace[1394695541] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25416; }","duration":"167.923149ms","start":"2026-06-08T04:23:47.859603Z","end":"2026-06-08T04:23:48.027526Z","steps":["trace[1394695541] 'agreement among raft nodes before linearized reading' (duration: 167.760236ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:48.02766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.499742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-08T04:23:48.027786Z","caller":"traceutil/trace.go:171","msg":"trace[805297748] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25416; }","duration":"173.691586ms","start":"2026-06-08T04:23:47.85406Z","end":"2026-06-08T04:23:48.027752Z","steps":["trace[805297748] 'agreement among raft nodes before linearized reading' (duration: 173.253588ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:54.0712Z","caller":"traceutil/trace.go:171","msg":"trace[1384466813] transaction","detail":"{read_only:false; response_revision:25457; number_of_response:1; }","duration":"195.370127ms","start":"2026-06-08T04:23:53.875783Z","end":"2026-06-08T04:23:54.071153Z","steps":["trace[1384466813] 'process raft request' (duration: 172.145225ms)","trace[1384466813] 'compare' (duration: 22.846175ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:23:54.387129Z","caller":"traceutil/trace.go:171","msg":"trace[1888562717] transaction","detail":"{read_only:false; response_revision:25458; number_of_response:1; }","duration":"339.622526ms","start":"2026-06-08T04:23:54.047475Z","end":"2026-06-08T04:23:54.387098Z","steps":["trace[1888562717] 'process raft request' (duration: 315.072917ms)","trace[1888562717] 'compare' (duration: 24.256162ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:23:54.387295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:54.047436Z","time spent":"339.766199ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:23:54.514455Z","caller":"traceutil/trace.go:171","msg":"trace[1061532086] transaction","detail":"{read_only:false; response_revision:25459; number_of_response:1; }","duration":"464.98224ms","start":"2026-06-08T04:23:54.049441Z","end":"2026-06-08T04:23:54.514423Z","steps":["trace[1061532086] 'process raft request' (duration: 454.702962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:54.514627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:54.049429Z","time spent":"465.107733ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T04:23:54.514802Z","caller":"traceutil/trace.go:171","msg":"trace[1231453841] linearizableReadLoop","detail":"{readStateIndex:26289; appliedIndex:26287; }","duration":"443.571055ms","start":"2026-06-08T04:23:54.071083Z","end":"2026-06-08T04:23:54.514654Z","steps":["trace[1231453841] 'read index received' (duration: 291.343355ms)","trace[1231453841] 'applied index is now lower than readState.Index' (duration: 152.22664ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:23:54.515001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.135282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-08T04:23:54.514835Z","caller":"traceutil/trace.go:171","msg":"trace[560171990] transaction","detail":"{read_only:false; response_revision:25460; number_of_response:1; }","duration":"361.665972ms","start":"2026-06-08T04:23:54.153094Z","end":"2026-06-08T04:23:54.51476Z","steps":["trace[560171990] 'process raft request' (duration: 361.164892ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:54.515095Z","caller":"traceutil/trace.go:171","msg":"trace[1579342366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25460; }","duration":"463.278905ms","start":"2026-06-08T04:23:54.051796Z","end":"2026-06-08T04:23:54.515075Z","steps":["trace[1579342366] 'agreement among raft nodes before linearized reading' (duration: 463.0247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:54.515147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:54.051775Z","time spent":"463.362617ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-08T04:23:54.515267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.037344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-08T04:23:54.515304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.018711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-06-08T04:23:54.515301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.905096ms","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-06-08T04:23:54.515338Z","caller":"traceutil/trace.go:171","msg":"trace[432804588] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25460; }","duration":"443.176377ms","start":"2026-06-08T04:23:54.072147Z","end":"2026-06-08T04:23:54.515324Z","steps":["trace[432804588] 'agreement among raft nodes before linearized reading' (duration: 443.005914ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:54.51536Z","caller":"traceutil/trace.go:171","msg":"trace[64559913] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25460; }","duration":"369.111013ms","start":"2026-06-08T04:23:54.146231Z","end":"2026-06-08T04:23:54.515342Z","steps":["trace[64559913] 'agreement among raft nodes before linearized reading' (duration: 368.931279ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:54.51538Z","caller":"traceutil/trace.go:171","msg":"trace[1541570280] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25460; }","duration":"389.046389ms","start":"2026-06-08T04:23:54.126322Z","end":"2026-06-08T04:23:54.515368Z","steps":["trace[1541570280] 'agreement among raft nodes before linearized reading' (duration: 388.856596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:23:54.515404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:54.146218Z","time spent":"369.177805ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-08T04:23:54.515404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:54.072129Z","time spent":"443.257539ms","remote":"127.0.0.1:38172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T04:23:54.51544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:54.126285Z","time spent":"389.12084ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T04:23:54.515888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T04:23:54.153056Z","time spent":"362.04632ms","remote":"127.0.0.1:38394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T04:23:54.812185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.191738ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-08T04:23:54.812762Z","caller":"traceutil/trace.go:171","msg":"trace[804900042] transaction","detail":"{read_only:false; response_revision:25463; number_of_response:1; }","duration":"291.280224ms","start":"2026-06-08T04:23:54.521466Z","end":"2026-06-08T04:23:54.812747Z","steps":["trace[804900042] 'process raft request' (duration: 290.917686ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:54.8128Z","caller":"traceutil/trace.go:171","msg":"trace[1907836473] transaction","detail":"{read_only:false; response_revision:25462; number_of_response:1; }","duration":"292.339365ms","start":"2026-06-08T04:23:54.520427Z","end":"2026-06-08T04:23:54.812766Z","steps":["trace[1907836473] 'process raft request' (duration: 291.876736ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:23:54.812429Z","caller":"traceutil/trace.go:171","msg":"trace[425042892] transaction","detail":"{read_only:false; response_revision:25461; number_of_response:1; }","duration":"292.737313ms","start":"2026-06-08T04:23:54.519666Z","end":"2026-06-08T04:23:54.812403Z","steps":["trace[425042892] 'process raft request' (duration: 147.226818ms)","trace[425042892] 'compare' (duration: 144.703399ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:24:08.997225Z","caller":"traceutil/trace.go:171","msg":"trace[418394982] linearizableReadLoop","detail":"{readStateIndex:26411; appliedIndex:26410; }","duration":"104.734587ms","start":"2026-06-08T04:24:08.892441Z","end":"2026-06-08T04:24:08.997175Z","steps":["trace[418394982] 'read index received' (duration: 81.504336ms)","trace[418394982] 'applied index is now lower than readState.Index' (duration: 23.229071ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:24:08.997407Z","caller":"traceutil/trace.go:171","msg":"trace[1827448473] transaction","detail":"{read_only:false; response_revision:25578; number_of_response:1; }","duration":"105.040753ms","start":"2026-06-08T04:24:08.892347Z","end":"2026-06-08T04:24:08.997387Z","steps":["trace[1827448473] 'process raft request' (duration: 104.688276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:24:08.997902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.424941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-08T04:24:08.998068Z","caller":"traceutil/trace.go:171","msg":"trace[845149505] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25578; }","duration":"105.671946ms","start":"2026-06-08T04:24:08.892367Z","end":"2026-06-08T04:24:08.998039Z","steps":["trace[845149505] 'agreement among raft nodes before linearized reading' (duration: 105.240967ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:24:16.121268Z","caller":"traceutil/trace.go:171","msg":"trace[860784634] linearizableReadLoop","detail":"{readStateIndex:26463; appliedIndex:26462; }","duration":"104.718125ms","start":"2026-06-08T04:24:16.016526Z","end":"2026-06-08T04:24:16.121244Z","steps":["trace[860784634] 'read index received' (duration: 104.536672ms)","trace[860784634] 'applied index is now lower than readState.Index' (duration: 180.613µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:24:16.121327Z","caller":"traceutil/trace.go:171","msg":"trace[1427546100] transaction","detail":"{read_only:false; response_revision:25629; number_of_response:1; }","duration":"106.215216ms","start":"2026-06-08T04:24:16.01507Z","end":"2026-06-08T04:24:16.121285Z","steps":["trace[1427546100] 'process raft request' (duration: 106.035893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:24:16.121422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.839018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-08T04:24:16.121469Z","caller":"traceutil/trace.go:171","msg":"trace[1124936134] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:25629; }","duration":"104.966681ms","start":"2026-06-08T04:24:16.016488Z","end":"2026-06-08T04:24:16.121454Z","steps":["trace[1124936134] 'agreement among raft nodes before linearized reading' (duration: 104.848048ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:24:34.537721Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000689b.wal"} {"level":"info","ts":"2026-06-08T04:24:43.86377Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23041} {"level":"info","ts":"2026-06-08T04:24:44.037644Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23041,"took":"169.772266ms","hash":980854754,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":35332096,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-08T04:24:44.03772Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":980854754,"revision":23041,"compact-revision":20068} {"level":"info","ts":"2026-06-08T04:29:43.869858Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26011} {"level":"info","ts":"2026-06-08T04:29:44.024633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26011,"took":"151.316052ms","hash":1873666656,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":34263040,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-08T04:29:44.024714Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1873666656,"revision":26011,"compact-revision":23041} {"level":"info","ts":"2026-06-08T04:30:28.679846Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf8c3a138c9a77a2","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-08T04:30:28.686566Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-08T04:30:28.686776Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-08T04:34:43.876248Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28710} {"level":"info","ts":"2026-06-08T04:34:44.018974Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28710,"took":"136.45437ms","hash":1905030155,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":30908416,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-08T04:34:44.019055Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1905030155,"revision":28710,"compact-revision":26011} {"level":"info","ts":"2026-06-08T04:39:43.882422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30935} {"level":"info","ts":"2026-06-08T04:39:43.997307Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30935,"took":"110.435732ms","hash":1800629700,"current-db-size-bytes":59215872,"current-db-size":"59 MB","current-db-size-in-use-bytes":31780864,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-08T04:39:43.997378Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1800629700,"revision":30935,"compact-revision":28710} {"level":"info","ts":"2026-06-08T04:44:43.894771Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33205} {"level":"info","ts":"2026-06-08T04:44:44.050275Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33205,"took":"151.522454ms","hash":682854515,"current-db-size-bytes":60260352,"current-db-size":"60 MB","current-db-size-in-use-bytes":31973376,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-08T04:44:44.050359Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":682854515,"revision":33205,"compact-revision":30935} {"level":"info","ts":"2026-06-08T04:49:43.903368Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35499} {"level":"info","ts":"2026-06-08T04:49:44.045054Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35499,"took":"136.661172ms","hash":3889817943,"current-db-size-bytes":60260352,"current-db-size":"60 MB","current-db-size-in-use-bytes":30449664,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-08T04:49:44.045139Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3889817943,"revision":35499,"compact-revision":33205} {"level":"info","ts":"2026-06-08T04:51:57.827533Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf8c3a138c9a77a2","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-08T04:51:57.870677Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-08T04:51:57.870787Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-08T04:52:00.009743Z","caller":"traceutil/trace.go:171","msg":"trace[934046959] transaction","detail":"{read_only:false; response_revision:38814; number_of_response:1; }","duration":"151.512864ms","start":"2026-06-08T04:51:59.858186Z","end":"2026-06-08T04:52:00.009699Z","steps":["trace[934046959] 'process raft request' (duration: 121.808281ms)","trace[934046959] 'compare' (duration: 29.481959ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:52:00.009759Z","caller":"traceutil/trace.go:171","msg":"trace[352397933] linearizableReadLoop","detail":"{readStateIndex:40019; appliedIndex:40018; }","duration":"119.015454ms","start":"2026-06-08T04:51:59.890709Z","end":"2026-06-08T04:52:00.009725Z","steps":["trace[352397933] 'read index received' (duration: 89.304011ms)","trace[352397933] 'applied index is now lower than readState.Index' (duration: 29.707333ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T04:52:00.010081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.918514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1316"} {"level":"info","ts":"2026-06-08T04:52:00.010134Z","caller":"traceutil/trace.go:171","msg":"trace[1506626277] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:38815; }","duration":"125.026227ms","start":"2026-06-08T04:51:59.885096Z","end":"2026-06-08T04:52:00.010122Z","steps":["trace[1506626277] 'agreement among raft nodes before linearized reading' (duration: 124.725301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:52:00.010551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.394112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1370"} {"level":"info","ts":"2026-06-08T04:52:00.01063Z","caller":"traceutil/trace.go:171","msg":"trace[278699215] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:38815; }","duration":"117.518014ms","start":"2026-06-08T04:51:59.893091Z","end":"2026-06-08T04:52:00.010609Z","steps":["trace[278699215] 'agreement among raft nodes before linearized reading' (duration: 117.250229ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T04:52:12.217002Z","caller":"traceutil/trace.go:171","msg":"trace[1749258166] transaction","detail":"{read_only:false; response_revision:38905; number_of_response:1; }","duration":"124.120928ms","start":"2026-06-08T04:52:12.092392Z","end":"2026-06-08T04:52:12.216513Z","steps":["trace[1749258166] 'process raft request' (duration: 123.846523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T04:52:12.250537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.867998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-defaultbackend\" ","response":"range_response_count:1 size:1508"} {"level":"info","ts":"2026-06-08T04:52:12.250639Z","caller":"traceutil/trace.go:171","msg":"trace[1944862251] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-defaultbackend; range_end:; response_count:1; response_revision:38905; }","duration":"138.014801ms","start":"2026-06-08T04:52:12.112598Z","end":"2026-06-08T04:52:12.250613Z","steps":["trace[1944862251] 'agreement among raft nodes before linearized reading' (duration: 104.336388ms)","trace[1944862251] 'range keys from in-memory index tree' (duration: 33.464689ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T04:54:43.910762Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37728} {"level":"info","ts":"2026-06-08T04:54:44.032188Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37728,"took":"118.157107ms","hash":301679287,"current-db-size-bytes":60260352,"current-db-size":"60 MB","current-db-size-in-use-bytes":30777344,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-08T04:54:44.03225Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":301679287,"revision":37728,"compact-revision":35499}