{"level":"warn","ts":"2026-07-30T20:55:20.688928Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T20:55:20.689028Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.150: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.19.213.150:2380","--initial-cluster=instance=https://199.19.213.150:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.150:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.150: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-07-30T20:55:20.68912Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T20:55:20.689133Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.150:2380"]} {"level":"info","ts":"2026-07-30T20:55:20.689151Z","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-07-30T20:55:20.691046Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.150:2379"]} {"level":"info","ts":"2026-07-30T20:55:20.69121Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.150:2380"],"listen-peer-urls":["https://199.19.213.150:2380"],"advertise-client-urls":["https://199.19.213.150:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.150:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.150: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-07-30T20:55:20.695535Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.886731ms"} {"level":"info","ts":"2026-07-30T20:55:20.707016Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dbd0ffa4f8c99812","cluster-id":"98aad832cd49bc30"} {"level":"info","ts":"2026-07-30T20:55:20.707163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 switched to configuration voters=()"} {"level":"info","ts":"2026-07-30T20:55:20.707197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became follower at term 0"} {"level":"info","ts":"2026-07-30T20:55:20.70721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dbd0ffa4f8c99812 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-30T20:55:20.707217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became follower at term 1"} {"level":"info","ts":"2026-07-30T20:55:20.707248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 switched to configuration voters=(15839440973475715090)"} {"level":"warn","ts":"2026-07-30T20:55:20.719398Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-30T20:55:20.725485Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-30T20:55:20.72685Z","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-07-30T20:55:20.730329Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dbd0ffa4f8c99812","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-30T20:55:20.730515Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dbd0ffa4f8c99812","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-30T20:55:20.73076Z","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-07-30T20:55:20.730852Z","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-07-30T20:55:20.730896Z","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-07-30T20:55:20.737574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 switched to configuration voters=(15839440973475715090)"} {"level":"info","ts":"2026-07-30T20:55:20.737863Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"98aad832cd49bc30","local-member-id":"dbd0ffa4f8c99812","added-peer-id":"dbd0ffa4f8c99812","added-peer-peer-urls":["https://199.19.213.150:2380"]} {"level":"info","ts":"2026-07-30T20:55:20.739948Z","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-07-30T20:55:20.740076Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.150:2380"} {"level":"info","ts":"2026-07-30T20:55:20.740137Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.150:2380"} {"level":"info","ts":"2026-07-30T20:55:20.740192Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dbd0ffa4f8c99812","initial-advertise-peer-urls":["https://199.19.213.150:2380"],"listen-peer-urls":["https://199.19.213.150:2380"],"advertise-client-urls":["https://199.19.213.150:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.150:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-30T20:55:20.74024Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-30T20:55:21.307473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 is starting a new election at term 1"} {"level":"info","ts":"2026-07-30T20:55:21.307547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-30T20:55:21.307583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 received MsgPreVoteResp from dbd0ffa4f8c99812 at term 1"} {"level":"info","ts":"2026-07-30T20:55:21.307604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became candidate at term 2"} {"level":"info","ts":"2026-07-30T20:55:21.307621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 received MsgVoteResp from dbd0ffa4f8c99812 at term 2"} {"level":"info","ts":"2026-07-30T20:55:21.307638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dbd0ffa4f8c99812 became leader at term 2"} {"level":"info","ts":"2026-07-30T20:55:21.307657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dbd0ffa4f8c99812 elected leader dbd0ffa4f8c99812 at term 2"} {"level":"info","ts":"2026-07-30T20:55:21.308557Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dbd0ffa4f8c99812","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.150:2379]}","request-path":"/0/members/dbd0ffa4f8c99812/attributes","cluster-id":"98aad832cd49bc30","publish-timeout":"7s"} {"level":"info","ts":"2026-07-30T20:55:21.308725Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T20:55:21.308909Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T20:55:21.309235Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T20:55:21.309439Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-30T20:55:21.309468Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-30T20:55:21.309985Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"98aad832cd49bc30","local-member-id":"dbd0ffa4f8c99812","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T20:55:21.31011Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T20:55:21.310148Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T20:55:21.311598Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-30T20:55:21.312219Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.150:2379"} {"level":"info","ts":"2026-07-30T20:55:44.361515Z","caller":"traceutil/trace.go:171","msg":"trace[2134861560] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"197.649028ms","start":"2026-07-30T20:55:44.163833Z","end":"2026-07-30T20:55:44.361482Z","steps":["trace[2134861560] 'process raft request' (duration: 197.478781ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:55:56.084222Z","caller":"traceutil/trace.go:171","msg":"trace[1488294816] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"101.887108ms","start":"2026-07-30T20:55:55.982287Z","end":"2026-07-30T20:55:56.084174Z","steps":["trace[1488294816] 'process raft request' (duration: 89.357902ms)","trace[1488294816] 'compare' (duration: 12.328267ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T20:55:56.084444Z","caller":"traceutil/trace.go:171","msg":"trace[1199420990] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"100.106444ms","start":"2026-07-30T20:55:55.984324Z","end":"2026-07-30T20:55:56.08443Z","steps":["trace[1199420990] 'process raft request' (duration: 100.032094ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:55:56.084428Z","caller":"traceutil/trace.go:171","msg":"trace[619121681] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"100.218023ms","start":"2026-07-30T20:55:55.984187Z","end":"2026-07-30T20:55:56.084405Z","steps":["trace[619121681] 'process raft request' (duration: 100.121673ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:55:56.084632Z","caller":"traceutil/trace.go:171","msg":"trace[1281431513] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"102.208167ms","start":"2026-07-30T20:55:55.982416Z","end":"2026-07-30T20:55:56.084624Z","steps":["trace[1281431513] 'process raft request' (duration: 101.810698ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:55:56.084652Z","caller":"traceutil/trace.go:171","msg":"trace[726377021] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"102.038458ms","start":"2026-07-30T20:55:55.982601Z","end":"2026-07-30T20:55:56.08464Z","steps":["trace[726377021] 'process raft request' (duration: 101.667269ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:55:56.084617Z","caller":"traceutil/trace.go:171","msg":"trace[1227707403] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"102.211968ms","start":"2026-07-30T20:55:55.982349Z","end":"2026-07-30T20:55:56.084561Z","steps":["trace[1227707403] 'process raft request' (duration: 101.758129ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:56:01.82476Z","caller":"traceutil/trace.go:171","msg":"trace[1067497673] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"141.792964ms","start":"2026-07-30T20:56:01.682887Z","end":"2026-07-30T20:56:01.82468Z","steps":["trace[1067497673] 'read index received' (duration: 131.220787ms)","trace[1067497673] 'applied index is now lower than readState.Index' (duration: 10.571027ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T20:56:01.824931Z","caller":"traceutil/trace.go:171","msg":"trace[371009190] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"280.586246ms","start":"2026-07-30T20:56:01.544312Z","end":"2026-07-30T20:56:01.824898Z","steps":["trace[371009190] 'process raft request' (duration: 279.741353ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T20:56:01.825031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.108985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-30T20:56:01.825104Z","caller":"traceutil/trace.go:171","msg":"trace[1874658945] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:602; }","duration":"142.251135ms","start":"2026-07-30T20:56:01.682841Z","end":"2026-07-30T20:56:01.825092Z","steps":["trace[1874658945] 'agreement among raft nodes before linearized reading' (duration: 142.078545ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:57:38.347765Z","caller":"traceutil/trace.go:171","msg":"trace[719872246] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"183.707833ms","start":"2026-07-30T20:57:38.164019Z","end":"2026-07-30T20:57:38.347727Z","steps":["trace[719872246] 'process raft request' (duration: 179.461129ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:57:38.34807Z","caller":"traceutil/trace.go:171","msg":"trace[2049038355] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"175.616257ms","start":"2026-07-30T20:57:38.172416Z","end":"2026-07-30T20:57:38.348033Z","steps":["trace[2049038355] 'process raft request' (duration: 175.252447ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:57:38.348131Z","caller":"traceutil/trace.go:171","msg":"trace[278266291] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1930; }","duration":"167.383863ms","start":"2026-07-30T20:57:38.180713Z","end":"2026-07-30T20:57:38.348097Z","steps":["trace[278266291] 'read index received' (duration: 17.254451ms)","trace[278266291] 'applied index is now lower than readState.Index' (duration: 150.127712ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T20:57:38.348225Z","caller":"traceutil/trace.go:171","msg":"trace[1376429738] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"163.176942ms","start":"2026-07-30T20:57:38.185003Z","end":"2026-07-30T20:57:38.34818Z","steps":["trace[1376429738] 'process raft request' (duration: 162.835413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T20:57:38.3485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.755133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-30T20:57:38.348556Z","caller":"traceutil/trace.go:171","msg":"trace[1434280166] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1862; }","duration":"167.88035ms","start":"2026-07-30T20:57:38.180661Z","end":"2026-07-30T20:57:38.348542Z","steps":["trace[1434280166] 'agreement among raft nodes before linearized reading' (duration: 167.578744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T20:57:38.34856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.63635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2d0a1d8b-66f8-4bfb-9961-9cd3d270b9c0\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-30T20:57:38.348603Z","caller":"traceutil/trace.go:171","msg":"trace[604098142] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2d0a1d8b-66f8-4bfb-9961-9cd3d270b9c0; range_end:; response_count:1; response_revision:1862; }","duration":"105.712904ms","start":"2026-07-30T20:57:38.242876Z","end":"2026-07-30T20:57:38.348589Z","steps":["trace[604098142] 'agreement among raft nodes before linearized reading' (duration: 105.567696ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T20:57:38.688627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.403983ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T20:57:38.688746Z","caller":"traceutil/trace.go:171","msg":"trace[852670383] linearizableReadLoop","detail":"{readStateIndex:1936; appliedIndex:1935; }","duration":"295.926786ms","start":"2026-07-30T20:57:38.392802Z","end":"2026-07-30T20:57:38.688729Z","steps":["trace[852670383] 'read index received' (duration: 184.080454ms)","trace[852670383] 'applied index is now lower than readState.Index' (duration: 111.844732ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T20:57:38.688925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.126528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-30T20:57:38.688964Z","caller":"traceutil/trace.go:171","msg":"trace[374830560] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1864; }","duration":"296.206432ms","start":"2026-07-30T20:57:38.392745Z","end":"2026-07-30T20:57:38.688952Z","steps":["trace[374830560] 'agreement among raft nodes before linearized reading' (duration: 296.039203ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:57:38.689186Z","caller":"traceutil/trace.go:171","msg":"trace[1534548622] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"332.592697ms","start":"2026-07-30T20:57:38.356581Z","end":"2026-07-30T20:57:38.689173Z","steps":["trace[1534548622] 'process raft request' (duration: 220.332181ms)","trace[1534548622] 'compare' (duration: 110.16264ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T20:57:38.689264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T20:57:38.356551Z","time spent":"332.66958ms","remote":"127.0.0.1:55394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T20:57:44.491716Z","caller":"traceutil/trace.go:171","msg":"trace[1817271736] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"109.333525ms","start":"2026-07-30T20:57:44.382335Z","end":"2026-07-30T20:57:44.491669Z","steps":["trace[1817271736] 'process raft request' (duration: 66.563173ms)","trace[1817271736] 'compare' (duration: 42.56157ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T20:57:50.744194Z","caller":"traceutil/trace.go:171","msg":"trace[149021294] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"223.428962ms","start":"2026-07-30T20:57:50.520741Z","end":"2026-07-30T20:57:50.74417Z","steps":["trace[149021294] 'process raft request' (duration: 223.249151ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:57:50.912495Z","caller":"traceutil/trace.go:171","msg":"trace[1571523284] linearizableReadLoop","detail":"{readStateIndex:2039; appliedIndex:2038; }","duration":"118.255017ms","start":"2026-07-30T20:57:50.794224Z","end":"2026-07-30T20:57:50.912479Z","steps":["trace[1571523284] 'read index received' (duration: 111.600584ms)","trace[1571523284] 'applied index is now lower than readState.Index' (duration: 6.653383ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T20:57:50.912553Z","caller":"traceutil/trace.go:171","msg":"trace[1152055974] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"162.76619ms","start":"2026-07-30T20:57:50.749741Z","end":"2026-07-30T20:57:50.912508Z","steps":["trace[1152055974] 'process raft request' (duration: 156.213003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T20:57:50.912692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.450978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T20:57:50.913197Z","caller":"traceutil/trace.go:171","msg":"trace[862957491] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1964; }","duration":"118.987279ms","start":"2026-07-30T20:57:50.794157Z","end":"2026-07-30T20:57:50.913144Z","steps":["trace[862957491] 'agreement among raft nodes before linearized reading' (duration: 118.449568ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:58:12.098648Z","caller":"traceutil/trace.go:171","msg":"trace[1400512697] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"153.778938ms","start":"2026-07-30T20:58:11.944851Z","end":"2026-07-30T20:58:12.09863Z","steps":["trace[1400512697] 'process raft request' (duration: 153.297518ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:58:12.67693Z","caller":"traceutil/trace.go:171","msg":"trace[884196749] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"195.207805ms","start":"2026-07-30T20:58:12.481682Z","end":"2026-07-30T20:58:12.676889Z","steps":["trace[884196749] 'process raft request' (duration: 157.477653ms)","trace[884196749] 'compare' (duration: 37.439344ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T20:58:13.23067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.050268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T20:58:13.230848Z","caller":"traceutil/trace.go:171","msg":"trace[1958854446] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:2099; }","duration":"167.272462ms","start":"2026-07-30T20:58:13.063551Z","end":"2026-07-30T20:58:13.230823Z","steps":["trace[1958854446] 'count revisions from in-memory index tree' (duration: 166.983294ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T20:58:13.230754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.908728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-30T20:58:13.231175Z","caller":"traceutil/trace.go:171","msg":"trace[1357316006] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2099; }","duration":"123.368426ms","start":"2026-07-30T20:58:13.107786Z","end":"2026-07-30T20:58:13.231155Z","steps":["trace[1357316006] 'range keys from in-memory index tree' (duration: 122.732187ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T20:58:13.231488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.847462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-30T20:58:13.231529Z","caller":"traceutil/trace.go:171","msg":"trace[1778195182] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2099; }","duration":"214.910525ms","start":"2026-07-30T20:58:13.01661Z","end":"2026-07-30T20:58:13.23152Z","steps":["trace[1778195182] 'range keys from in-memory index tree' (duration: 214.755476ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:58:13.494874Z","caller":"traceutil/trace.go:171","msg":"trace[1810677406] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2179; }","duration":"187.373291ms","start":"2026-07-30T20:58:13.307469Z","end":"2026-07-30T20:58:13.494842Z","steps":["trace[1810677406] 'read index received' (duration: 187.270455ms)","trace[1810677406] 'applied index is now lower than readState.Index' (duration: 101.306µs)"],"step_count":2} {"level":"warn","ts":"2026-07-30T20:58:13.49504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.539091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T20:58:13.495089Z","caller":"traceutil/trace.go:171","msg":"trace[1820598387] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2101; }","duration":"187.635737ms","start":"2026-07-30T20:58:13.307436Z","end":"2026-07-30T20:58:13.495072Z","steps":["trace[1820598387] 'agreement among raft nodes before linearized reading' (duration: 187.541171ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:58:13.495103Z","caller":"traceutil/trace.go:171","msg":"trace[2130589890] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"197.895234ms","start":"2026-07-30T20:58:13.297012Z","end":"2026-07-30T20:58:13.494907Z","steps":["trace[2130589890] 'process raft request' (duration: 197.652819ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:58:13.641957Z","caller":"traceutil/trace.go:171","msg":"trace[357758466] linearizableReadLoop","detail":"{readStateIndex:2181; appliedIndex:2180; }","duration":"146.974629ms","start":"2026-07-30T20:58:13.494948Z","end":"2026-07-30T20:58:13.641923Z","steps":["trace[357758466] 'read index received' (duration: 114.207655ms)","trace[357758466] 'applied index is now lower than readState.Index' (duration: 32.765653ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T20:58:13.642015Z","caller":"traceutil/trace.go:171","msg":"trace[678194087] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"250.380745ms","start":"2026-07-30T20:58:13.391608Z","end":"2026-07-30T20:58:13.641989Z","steps":["trace[678194087] 'process raft request' (duration: 217.529595ms)","trace[678194087] 'compare' (duration: 32.627235ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T20:58:13.642584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.12002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-30T20:58:13.642667Z","caller":"traceutil/trace.go:171","msg":"trace[2039334501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2102; }","duration":"328.336383ms","start":"2026-07-30T20:58:13.31431Z","end":"2026-07-30T20:58:13.642647Z","steps":["trace[2039334501] 'agreement among raft nodes before linearized reading' (duration: 327.79426ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T20:58:13.642628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.760344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-30T20:58:13.642722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T20:58:13.314288Z","time spent":"328.426178ms","remote":"127.0.0.1:55466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-30T20:58:13.642746Z","caller":"traceutil/trace.go:171","msg":"trace[659955850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2102; }","duration":"333.959026ms","start":"2026-07-30T20:58:13.308755Z","end":"2026-07-30T20:58:13.642714Z","steps":["trace[659955850] 'agreement among raft nodes before linearized reading' (duration: 333.301096ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T20:58:13.642837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T20:58:13.308751Z","time spent":"334.069063ms","remote":"127.0.0.1:55466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-30T20:59:40.976436Z","caller":"traceutil/trace.go:171","msg":"trace[826715519] transaction","detail":"{read_only:false; response_revision:2685; number_of_response:1; }","duration":"169.039533ms","start":"2026-07-30T20:59:40.807378Z","end":"2026-07-30T20:59:40.976418Z","steps":["trace[826715519] 'process raft request' (duration: 168.918548ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:59:41.02936Z","caller":"traceutil/trace.go:171","msg":"trace[528057080] transaction","detail":"{read_only:false; response_revision:2686; number_of_response:1; }","duration":"206.085876ms","start":"2026-07-30T20:59:40.823248Z","end":"2026-07-30T20:59:41.029334Z","steps":["trace[528057080] 'process raft request' (duration: 200.985304ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T20:59:41.029404Z","caller":"traceutil/trace.go:171","msg":"trace[622225012] linearizableReadLoop","detail":"{readStateIndex:2786; appliedIndex:2785; }","duration":"135.579981ms","start":"2026-07-30T20:59:40.893798Z","end":"2026-07-30T20:59:41.029378Z","steps":["trace[622225012] 'read index received' (duration: 82.789072ms)","trace[622225012] 'applied index is now lower than readState.Index' (duration: 52.789689ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T20:59:41.029629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.803791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T20:59:41.029675Z","caller":"traceutil/trace.go:171","msg":"trace[1205023592] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2687; }","duration":"135.912646ms","start":"2026-07-30T20:59:40.89375Z","end":"2026-07-30T20:59:41.029663Z","steps":["trace[1205023592] 'agreement among raft nodes before linearized reading' (duration: 135.720635ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:20.366333Z","caller":"traceutil/trace.go:171","msg":"trace[1974102747] transaction","detail":"{read_only:false; response_revision:4520; number_of_response:1; }","duration":"100.572734ms","start":"2026-07-30T21:03:20.265732Z","end":"2026-07-30T21:03:20.366304Z","steps":["trace[1974102747] 'process raft request' (duration: 45.639768ms)","trace[1974102747] 'compare' (duration: 54.790661ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:03:20.534296Z","caller":"traceutil/trace.go:171","msg":"trace[548621536] linearizableReadLoop","detail":"{readStateIndex:4690; appliedIndex:4689; }","duration":"159.536317ms","start":"2026-07-30T21:03:20.374735Z","end":"2026-07-30T21:03:20.534271Z","steps":["trace[548621536] 'read index received' (duration: 93.278761ms)","trace[548621536] 'applied index is now lower than readState.Index' (duration: 66.256506ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:03:20.534417Z","caller":"traceutil/trace.go:171","msg":"trace[1770254284] transaction","detail":"{read_only:false; response_revision:4521; number_of_response:1; }","duration":"264.367154ms","start":"2026-07-30T21:03:20.270037Z","end":"2026-07-30T21:03:20.534404Z","steps":["trace[1770254284] 'process raft request' (duration: 198.245414ms)","trace[1770254284] 'compare' (duration: 65.882841ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:03:20.534711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.951693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-07-30T21:03:20.53478Z","caller":"traceutil/trace.go:171","msg":"trace[1662416295] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4521; }","duration":"160.056397ms","start":"2026-07-30T21:03:20.374706Z","end":"2026-07-30T21:03:20.534762Z","steps":["trace[1662416295] 'agreement among raft nodes before linearized reading' (duration: 159.87974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:03:20.534721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.041336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-30T21:03:20.535026Z","caller":"traceutil/trace.go:171","msg":"trace[522886779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4521; }","duration":"105.366219ms","start":"2026-07-30T21:03:20.429629Z","end":"2026-07-30T21:03:20.534996Z","steps":["trace[522886779] 'agreement among raft nodes before linearized reading' (duration: 104.954303ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:20.877037Z","caller":"traceutil/trace.go:171","msg":"trace[433511690] linearizableReadLoop","detail":"{readStateIndex:4692; appliedIndex:4690; }","duration":"331.994512ms","start":"2026-07-30T21:03:20.545018Z","end":"2026-07-30T21:03:20.877012Z","steps":["trace[433511690] 'read index received' (duration: 25.219016ms)","trace[433511690] 'applied index is now lower than readState.Index' (duration: 306.774336ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:03:20.877105Z","caller":"traceutil/trace.go:171","msg":"trace[1573327893] transaction","detail":"{read_only:false; response_revision:4523; number_of_response:1; }","duration":"333.784433ms","start":"2026-07-30T21:03:20.543286Z","end":"2026-07-30T21:03:20.87707Z","steps":["trace[1573327893] 'process raft request' (duration: 333.496861ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:20.877156Z","caller":"traceutil/trace.go:171","msg":"trace[917736712] transaction","detail":"{read_only:false; response_revision:4524; number_of_response:1; }","duration":"326.640995ms","start":"2026-07-30T21:03:20.550483Z","end":"2026-07-30T21:03:20.877124Z","steps":["trace[917736712] 'process raft request' (duration: 326.451867ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:03:20.877231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:03:20.543266Z","time spent":"333.898997ms","remote":"127.0.0.1:55466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T21:03:20.877305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.229782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-07-30T21:03:20.877351Z","caller":"traceutil/trace.go:171","msg":"trace[1467152378] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4524; }","duration":"332.357057ms","start":"2026-07-30T21:03:20.544982Z","end":"2026-07-30T21:03:20.877339Z","steps":["trace[1467152378] 'agreement among raft nodes before linearized reading' (duration: 332.148369ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:03:20.877343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:03:20.550465Z","time spent":"326.765891ms","remote":"127.0.0.1:37542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3300,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T21:03:20.877395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:03:20.544966Z","time spent":"332.420089ms","remote":"127.0.0.1:55314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1367,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "} {"level":"warn","ts":"2026-07-30T21:03:20.902364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.109864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-07-30T21:03:20.902438Z","caller":"traceutil/trace.go:171","msg":"trace[2094656910] transaction","detail":"{read_only:false; response_revision:4525; number_of_response:1; }","duration":"235.501058ms","start":"2026-07-30T21:03:20.666895Z","end":"2026-07-30T21:03:20.902396Z","steps":["trace[2094656910] 'process raft request' (duration: 235.166644ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:20.902554Z","caller":"traceutil/trace.go:171","msg":"trace[1870449926] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4525; }","duration":"328.28156ms","start":"2026-07-30T21:03:20.574215Z","end":"2026-07-30T21:03:20.902496Z","steps":["trace[1870449926] 'agreement among raft nodes before linearized reading' (duration: 327.993688ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:03:20.902383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.522719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-07-30T21:03:20.902634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:03:20.574205Z","time spent":"328.415256ms","remote":"127.0.0.1:55314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1845,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-07-30T21:03:20.902678Z","caller":"traceutil/trace.go:171","msg":"trace[1260041774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4525; }","duration":"157.823691ms","start":"2026-07-30T21:03:20.744837Z","end":"2026-07-30T21:03:20.90266Z","steps":["trace[1260041774] 'agreement among raft nodes before linearized reading' (duration: 157.368833ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:21.011874Z","caller":"traceutil/trace.go:171","msg":"trace[1877472368] transaction","detail":"{read_only:false; response_revision:4526; number_of_response:1; }","duration":"128.693383ms","start":"2026-07-30T21:03:20.883148Z","end":"2026-07-30T21:03:21.011842Z","steps":["trace[1877472368] 'process raft request' (duration: 101.980037ms)","trace[1877472368] 'compare' (duration: 26.492587ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:03:21.012008Z","caller":"traceutil/trace.go:171","msg":"trace[93964611] transaction","detail":"{read_only:false; response_revision:4528; number_of_response:1; }","duration":"127.476616ms","start":"2026-07-30T21:03:20.884486Z","end":"2026-07-30T21:03:21.011963Z","steps":["trace[93964611] 'process raft request' (duration: 127.29814ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:21.012277Z","caller":"traceutil/trace.go:171","msg":"trace[1540067349] transaction","detail":"{read_only:false; response_revision:4529; number_of_response:1; }","duration":"127.678255ms","start":"2026-07-30T21:03:20.884576Z","end":"2026-07-30T21:03:21.012254Z","steps":["trace[1540067349] 'process raft request' (duration: 127.238938ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:21.012283Z","caller":"traceutil/trace.go:171","msg":"trace[1181850793] transaction","detail":"{read_only:false; response_revision:4530; number_of_response:1; }","duration":"127.515948ms","start":"2026-07-30T21:03:20.884726Z","end":"2026-07-30T21:03:21.012242Z","steps":["trace[1181850793] 'process raft request' (duration: 127.117713ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:21.012426Z","caller":"traceutil/trace.go:171","msg":"trace[339777371] transaction","detail":"{read_only:false; response_revision:4531; number_of_response:1; }","duration":"126.743778ms","start":"2026-07-30T21:03:20.885668Z","end":"2026-07-30T21:03:21.012412Z","steps":["trace[339777371] 'process raft request' (duration: 126.215597ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:21.012508Z","caller":"traceutil/trace.go:171","msg":"trace[1479453743] linearizableReadLoop","detail":"{readStateIndex:4701; appliedIndex:4694; }","duration":"110.296321ms","start":"2026-07-30T21:03:20.902183Z","end":"2026-07-30T21:03:21.012479Z","steps":["trace[1479453743] 'read index received' (duration: 82.961732ms)","trace[1479453743] 'applied index is now lower than readState.Index' (duration: 27.331149ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:03:21.012608Z","caller":"traceutil/trace.go:171","msg":"trace[664082988] transaction","detail":"{read_only:false; response_revision:4532; number_of_response:1; }","duration":"121.437742ms","start":"2026-07-30T21:03:20.891137Z","end":"2026-07-30T21:03:21.012574Z","steps":["trace[664082988] 'process raft request' (duration: 120.797907ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:21.012835Z","caller":"traceutil/trace.go:171","msg":"trace[243172710] transaction","detail":"{read_only:false; response_revision:4527; number_of_response:1; }","duration":"128.885041ms","start":"2026-07-30T21:03:20.883936Z","end":"2026-07-30T21:03:21.012821Z","steps":["trace[243172710] 'process raft request' (duration: 127.804669ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:03:21.012844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.201441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-07-30T21:03:21.013018Z","caller":"traceutil/trace.go:171","msg":"trace[1714762893] transaction","detail":"{read_only:false; response_revision:4533; number_of_response:1; }","duration":"107.42167ms","start":"2026-07-30T21:03:20.905581Z","end":"2026-07-30T21:03:21.013002Z","steps":["trace[1714762893] 'process raft request' (duration: 106.415741ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:21.013142Z","caller":"traceutil/trace.go:171","msg":"trace[1847244802] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4534; }","duration":"131.44587ms","start":"2026-07-30T21:03:20.881562Z","end":"2026-07-30T21:03:21.013008Z","steps":["trace[1847244802] 'agreement among raft nodes before linearized reading' (duration: 131.128938ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:21.166642Z","caller":"traceutil/trace.go:171","msg":"trace[89425261] linearizableReadLoop","detail":"{readStateIndex:4707; appliedIndex:4704; }","duration":"103.862595ms","start":"2026-07-30T21:03:21.062757Z","end":"2026-07-30T21:03:21.16662Z","steps":["trace[89425261] 'read index received' (duration: 72.480736ms)","trace[89425261] 'applied index is now lower than readState.Index' (duration: 31.381059ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:03:21.166673Z","caller":"traceutil/trace.go:171","msg":"trace[1544974870] transaction","detail":"{read_only:false; response_revision:4537; number_of_response:1; }","duration":"142.146153ms","start":"2026-07-30T21:03:21.024507Z","end":"2026-07-30T21:03:21.166653Z","steps":["trace[1544974870] 'process raft request' (duration: 142.002158ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:21.166881Z","caller":"traceutil/trace.go:171","msg":"trace[798649587] transaction","detail":"{read_only:false; response_revision:4536; number_of_response:1; }","duration":"142.673723ms","start":"2026-07-30T21:03:21.024193Z","end":"2026-07-30T21:03:21.166867Z","steps":["trace[798649587] 'process raft request' (duration: 111.090187ms)","trace[798649587] 'compare' (duration: 31.083837ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:03:21.166928Z","caller":"traceutil/trace.go:171","msg":"trace[774613080] transaction","detail":"{read_only:false; response_revision:4538; number_of_response:1; }","duration":"138.893157ms","start":"2026-07-30T21:03:21.028023Z","end":"2026-07-30T21:03:21.166916Z","steps":["trace[774613080] 'process raft request' (duration: 138.531143ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:03:21.167176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.473795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-07-30T21:03:21.167225Z","caller":"traceutil/trace.go:171","msg":"trace[1370425696] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4538; }","duration":"142.561179ms","start":"2026-07-30T21:03:21.024651Z","end":"2026-07-30T21:03:21.167212Z","steps":["trace[1370425696] 'agreement among raft nodes before linearized reading' (duration: 142.413753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:03:27.730055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.575686ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-30T21:03:27.730191Z","caller":"traceutil/trace.go:171","msg":"trace[1743503817] linearizableReadLoop","detail":"{readStateIndex:4833; appliedIndex:4832; }","duration":"122.157336ms","start":"2026-07-30T21:03:27.608012Z","end":"2026-07-30T21:03:27.730169Z","steps":["trace[1743503817] 'read index received' (duration: 53.992µs)","trace[1743503817] 'applied index is now lower than readState.Index' (duration: 122.101494ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:03:27.730345Z","caller":"traceutil/trace.go:171","msg":"trace[2003410557] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"331.578353ms","start":"2026-07-30T21:03:27.398725Z","end":"2026-07-30T21:03:27.730303Z","steps":["trace[2003410557] 'process raft request' (duration: 132.656893ms)","trace[2003410557] 'compare' (duration: 198.218203ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:03:27.730418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:03:27.398696Z","time spent":"331.689367ms","remote":"127.0.0.1:55306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T21:03:27.730685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.604975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T21:03:27.730804Z","caller":"traceutil/trace.go:171","msg":"trace[2045951410] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4661; }","duration":"117.789522ms","start":"2026-07-30T21:03:27.612985Z","end":"2026-07-30T21:03:27.730775Z","steps":["trace[2045951410] 'agreement among raft nodes before linearized reading' (duration: 117.50145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:03:27.732775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.951947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-167cd1eb-3295-4f44-b448-9ce7912500df\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-07-30T21:03:27.732851Z","caller":"traceutil/trace.go:171","msg":"trace[143733069] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-167cd1eb-3295-4f44-b448-9ce7912500df; range_end:; response_count:1; response_revision:4661; }","duration":"124.870473ms","start":"2026-07-30T21:03:27.607962Z","end":"2026-07-30T21:03:27.732832Z","steps":["trace[143733069] 'agreement among raft nodes before linearized reading' (duration: 122.861674ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:03:27.733735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.519132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-30T21:03:27.733844Z","caller":"traceutil/trace.go:171","msg":"trace[1966618067] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4661; }","duration":"113.697489ms","start":"2026-07-30T21:03:27.620122Z","end":"2026-07-30T21:03:27.73382Z","steps":["trace[1966618067] 'agreement among raft nodes before linearized reading' (duration: 112.796114ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:28.184023Z","caller":"traceutil/trace.go:171","msg":"trace[1301681144] linearizableReadLoop","detail":"{readStateIndex:4839; appliedIndex:4837; }","duration":"143.783653ms","start":"2026-07-30T21:03:28.040211Z","end":"2026-07-30T21:03:28.183995Z","steps":["trace[1301681144] 'read index received' (duration: 16.456505ms)","trace[1301681144] 'applied index is now lower than readState.Index' (duration: 127.325788ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:03:28.184257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.020732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-07-30T21:03:28.184256Z","caller":"traceutil/trace.go:171","msg":"trace[958512788] transaction","detail":"{read_only:false; response_revision:4667; number_of_response:1; }","duration":"199.096021ms","start":"2026-07-30T21:03:27.985134Z","end":"2026-07-30T21:03:28.18423Z","steps":["trace[958512788] 'process raft request' (duration: 198.701525ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:28.184309Z","caller":"traceutil/trace.go:171","msg":"trace[1760473935] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4667; }","duration":"144.089955ms","start":"2026-07-30T21:03:28.040205Z","end":"2026-07-30T21:03:28.184295Z","steps":["trace[1760473935] 'agreement among raft nodes before linearized reading' (duration: 143.894817ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:03:41.070975Z","caller":"traceutil/trace.go:171","msg":"trace[130892758] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"101.165766ms","start":"2026-07-30T21:03:40.969774Z","end":"2026-07-30T21:03:41.07094Z","steps":["trace[130892758] 'process raft request' (duration: 65.136593ms)","trace[130892758] 'compare' (duration: 35.822624ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:03:41.403897Z","caller":"traceutil/trace.go:171","msg":"trace[1755981513] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"111.997359ms","start":"2026-07-30T21:03:41.29186Z","end":"2026-07-30T21:03:41.403857Z","steps":["trace[1755981513] 'process raft request' (duration: 39.817559ms)","trace[1755981513] 'compare' (duration: 72.008372ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:05:21.346493Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2897} {"level":"info","ts":"2026-07-30T21:05:21.419511Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2897,"took":"71.716899ms","hash":1918285053,"current-db-size-bytes":55332864,"current-db-size":"55 MB","current-db-size-in-use-bytes":29913088,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-30T21:05:21.419566Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1918285053,"revision":2897,"compact-revision":-1} {"level":"info","ts":"2026-07-30T21:07:22.422008Z","caller":"traceutil/trace.go:171","msg":"trace[4975134] transaction","detail":"{read_only:false; response_revision:6442; number_of_response:1; }","duration":"134.768597ms","start":"2026-07-30T21:07:22.287209Z","end":"2026-07-30T21:07:22.421978Z","steps":["trace[4975134] 'process raft request' (duration: 134.603668ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:07:22.943254Z","caller":"traceutil/trace.go:171","msg":"trace[575504327] transaction","detail":"{read_only:false; response_revision:6447; number_of_response:1; }","duration":"101.067903ms","start":"2026-07-30T21:07:22.842138Z","end":"2026-07-30T21:07:22.943205Z","steps":["trace[575504327] 'process raft request' (duration: 100.902944ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:07:23.574479Z","caller":"traceutil/trace.go:171","msg":"trace[421726635] transaction","detail":"{read_only:false; response_revision:6448; number_of_response:1; }","duration":"116.77498ms","start":"2026-07-30T21:07:23.457679Z","end":"2026-07-30T21:07:23.574454Z","steps":["trace[421726635] 'process raft request' (duration: 116.612251ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:07:23.615544Z","caller":"traceutil/trace.go:171","msg":"trace[505624064] transaction","detail":"{read_only:false; response_revision:6449; number_of_response:1; }","duration":"133.691162ms","start":"2026-07-30T21:07:23.481824Z","end":"2026-07-30T21:07:23.615515Z","steps":["trace[505624064] 'process raft request' (duration: 133.46636ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:07:23.615647Z","caller":"traceutil/trace.go:171","msg":"trace[663580953] linearizableReadLoop","detail":"{readStateIndex:6681; appliedIndex:6679; }","duration":"129.716267ms","start":"2026-07-30T21:07:23.485702Z","end":"2026-07-30T21:07:23.615419Z","steps":["trace[663580953] 'read index received' (duration: 88.535259ms)","trace[663580953] 'applied index is now lower than readState.Index' (duration: 41.179918ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:07:23.615668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.935709ms","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:5"} {"level":"info","ts":"2026-07-30T21:07:23.616146Z","caller":"traceutil/trace.go:171","msg":"trace[1168092484] 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:6449; }","duration":"130.473298ms","start":"2026-07-30T21:07:23.485648Z","end":"2026-07-30T21:07:23.616121Z","steps":["trace[1168092484] 'agreement among raft nodes before linearized reading' (duration: 129.918198ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:07:42.820881Z","caller":"traceutil/trace.go:171","msg":"trace[243545276] transaction","detail":"{read_only:false; response_revision:6601; number_of_response:1; }","duration":"142.719191ms","start":"2026-07-30T21:07:42.678131Z","end":"2026-07-30T21:07:42.82085Z","steps":["trace[243545276] 'process raft request' (duration: 91.46404ms)","trace[243545276] 'compare' (duration: 51.065419ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:07:42.821198Z","caller":"traceutil/trace.go:171","msg":"trace[551733695] transaction","detail":"{read_only:false; response_revision:6602; number_of_response:1; }","duration":"141.280343ms","start":"2026-07-30T21:07:42.679891Z","end":"2026-07-30T21:07:42.821171Z","steps":["trace[551733695] 'process raft request' (duration: 140.890972ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:07:42.821489Z","caller":"traceutil/trace.go:171","msg":"trace[1228755344] transaction","detail":"{read_only:false; response_revision:6603; number_of_response:1; }","duration":"139.57917ms","start":"2026-07-30T21:07:42.681893Z","end":"2026-07-30T21:07:42.821472Z","steps":["trace[1228755344] 'process raft request' (duration: 139.183839ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:10:21.353218Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5623} {"level":"info","ts":"2026-07-30T21:10:21.480618Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5623,"took":"125.685455ms","hash":3618003052,"current-db-size-bytes":55332864,"current-db-size":"55 MB","current-db-size-in-use-bytes":18538496,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-30T21:10:21.480701Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3618003052,"revision":5623,"compact-revision":2897}