{"level":"warn","ts":"2026-09-08T15:36:35.291764Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-08T15:36:35.291889Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.24: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://162.253.55.24:2380","--initial-cluster=instance=https://162.253.55.24:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.24:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.24: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-09-08T15:36:35.291995Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-08T15:36:35.292012Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.24:2380"]} {"level":"info","ts":"2026-09-08T15:36:35.29204Z","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-09-08T15:36:35.292635Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.24:2379"]} {"level":"info","ts":"2026-09-08T15:36:35.292718Z","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://162.253.55.24:2380"],"listen-peer-urls":["https://162.253.55.24:2380"],"advertise-client-urls":["https://162.253.55.24:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.24:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.24: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-09-08T15:36:35.334444Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"41.467123ms"} {"level":"info","ts":"2026-09-08T15:36:35.348541Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7a47c02f9bc0b904","cluster-id":"318a7363fda604da"} {"level":"info","ts":"2026-09-08T15:36:35.348678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 switched to configuration voters=()"} {"level":"info","ts":"2026-09-08T15:36:35.348714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 became follower at term 0"} {"level":"info","ts":"2026-09-08T15:36:35.348739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7a47c02f9bc0b904 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-08T15:36:35.348756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 became follower at term 1"} {"level":"info","ts":"2026-09-08T15:36:35.348819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 switched to configuration voters=(8811222506682759428)"} {"level":"warn","ts":"2026-09-08T15:36:35.358174Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-08T15:36:35.36122Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-08T15:36:35.363016Z","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-09-08T15:36:35.365467Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7a47c02f9bc0b904","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-08T15:36:35.365821Z","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-09-08T15:36:35.365985Z","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-09-08T15:36:35.365996Z","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-09-08T15:36:35.36585Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7a47c02f9bc0b904","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-08T15:36:35.366839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 switched to configuration voters=(8811222506682759428)"} {"level":"info","ts":"2026-09-08T15:36:35.367031Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"318a7363fda604da","local-member-id":"7a47c02f9bc0b904","added-peer-id":"7a47c02f9bc0b904","added-peer-peer-urls":["https://162.253.55.24:2380"]} {"level":"info","ts":"2026-09-08T15:36:35.368797Z","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-09-08T15:36:35.369056Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7a47c02f9bc0b904","initial-advertise-peer-urls":["https://162.253.55.24:2380"],"listen-peer-urls":["https://162.253.55.24:2380"],"advertise-client-urls":["https://162.253.55.24:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.24:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-08T15:36:35.369093Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-08T15:36:35.369247Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.24:2380"} {"level":"info","ts":"2026-09-08T15:36:35.369285Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.24:2380"} {"level":"info","ts":"2026-09-08T15:36:36.349715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 is starting a new election at term 1"} {"level":"info","ts":"2026-09-08T15:36:36.349802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-08T15:36:36.34986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 received MsgPreVoteResp from 7a47c02f9bc0b904 at term 1"} {"level":"info","ts":"2026-09-08T15:36:36.349882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 became candidate at term 2"} {"level":"info","ts":"2026-09-08T15:36:36.349893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 received MsgVoteResp from 7a47c02f9bc0b904 at term 2"} {"level":"info","ts":"2026-09-08T15:36:36.349912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7a47c02f9bc0b904 became leader at term 2"} {"level":"info","ts":"2026-09-08T15:36:36.349966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7a47c02f9bc0b904 elected leader 7a47c02f9bc0b904 at term 2"} {"level":"info","ts":"2026-09-08T15:36:36.351126Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T15:36:36.353214Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7a47c02f9bc0b904","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.24:2379]}","request-path":"/0/members/7a47c02f9bc0b904/attributes","cluster-id":"318a7363fda604da","publish-timeout":"7s"} {"level":"info","ts":"2026-09-08T15:36:36.353223Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-08T15:36:36.353257Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-08T15:36:36.353544Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-08T15:36:36.353568Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-08T15:36:36.356524Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-08T15:36:36.357527Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"318a7363fda604da","local-member-id":"7a47c02f9bc0b904","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T15:36:36.357657Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T15:36:36.357689Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T15:36:36.358038Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.24:2379"} {"level":"info","ts":"2026-09-08T15:37:17.729517Z","caller":"traceutil/trace.go:171","msg":"trace[950789774] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"195.573305ms","start":"2026-09-08T15:37:17.533918Z","end":"2026-09-08T15:37:17.729491Z","steps":["trace[950789774] 'read index received' (duration: 111.137671ms)","trace[950789774] 'applied index is now lower than readState.Index' (duration: 84.433464ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:37:17.729517Z","caller":"traceutil/trace.go:171","msg":"trace[124001163] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"244.736382ms","start":"2026-09-08T15:37:17.484702Z","end":"2026-09-08T15:37:17.729438Z","steps":["trace[124001163] 'process raft request' (duration: 160.447042ms)","trace[124001163] 'compare' (duration: 84.066514ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:37:17.729807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.864432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-09-08T15:37:17.729886Z","caller":"traceutil/trace.go:171","msg":"trace[936778869] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:582; }","duration":"195.992856ms","start":"2026-09-08T15:37:17.533878Z","end":"2026-09-08T15:37:17.729871Z","steps":["trace[936778869] 'agreement among raft nodes before linearized reading' (duration: 195.753289ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:37:18.189538Z","caller":"traceutil/trace.go:171","msg":"trace[476609504] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"233.771766ms","start":"2026-09-08T15:37:17.955737Z","end":"2026-09-08T15:37:18.189509Z","steps":["trace[476609504] 'read index received' (duration: 233.370115ms)","trace[476609504] 'applied index is now lower than readState.Index' (duration: 400.231µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:37:18.189666Z","caller":"traceutil/trace.go:171","msg":"trace[638789556] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"237.63388ms","start":"2026-09-08T15:37:17.952021Z","end":"2026-09-08T15:37:18.189654Z","steps":["trace[638789556] 'process raft request' (duration: 237.117886ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:37:18.190151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.361703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-09-08T15:37:18.190485Z","caller":"traceutil/trace.go:171","msg":"trace[265041041] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:591; }","duration":"234.733462ms","start":"2026-09-08T15:37:17.955717Z","end":"2026-09-08T15:37:18.190451Z","steps":["trace[265041041] 'agreement among raft nodes before linearized reading' (duration: 234.088805ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:37:18.200605Z","caller":"traceutil/trace.go:171","msg":"trace[1164259124] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"141.39777ms","start":"2026-09-08T15:37:18.059166Z","end":"2026-09-08T15:37:18.200563Z","steps":["trace[1164259124] 'process raft request' (duration: 141.05998ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:37:18.200635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.505552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-gtck7\" ","response":"range_response_count:1 size:4884"} {"level":"info","ts":"2026-09-08T15:37:18.201864Z","caller":"traceutil/trace.go:171","msg":"trace[2089748018] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-gtck7; range_end:; response_count:1; response_revision:592; }","duration":"217.796596ms","start":"2026-09-08T15:37:17.984042Z","end":"2026-09-08T15:37:18.201839Z","steps":["trace[2089748018] 'agreement among raft nodes before linearized reading' (duration: 216.268624ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:37:24.982483Z","caller":"traceutil/trace.go:171","msg":"trace[535978034] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"128.925546ms","start":"2026-09-08T15:37:24.853517Z","end":"2026-09-08T15:37:24.982443Z","steps":["trace[535978034] 'process raft request' (duration: 52.830519ms)","trace[535978034] 'compare' (duration: 75.921233ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:37:25.738317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.001067ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T15:37:25.73848Z","caller":"traceutil/trace.go:171","msg":"trace[1606549617] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"261.81071ms","start":"2026-09-08T15:37:25.476649Z","end":"2026-09-08T15:37:25.73846Z","steps":["trace[1606549617] 'read index received' (duration: 25.922622ms)","trace[1606549617] 'applied index is now lower than readState.Index' (duration: 235.886378ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:37:25.738576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.936374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:37:25.738603Z","caller":"traceutil/trace.go:171","msg":"trace[1407240471] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:662; }","duration":"262.007366ms","start":"2026-09-08T15:37:25.476586Z","end":"2026-09-08T15:37:25.738593Z","steps":["trace[1407240471] 'agreement among raft nodes before linearized reading' (duration: 261.936524ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:37:25.738577Z","caller":"traceutil/trace.go:171","msg":"trace[430591668] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"602.584636ms","start":"2026-09-08T15:37:25.135924Z","end":"2026-09-08T15:37:25.738509Z","steps":["trace[430591668] 'process raft request' (duration: 366.656436ms)","trace[430591668] 'compare' (duration: 234.649237ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:37:25.738875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:37:25.135897Z","time spent":"602.850222ms","remote":"127.0.0.1:52710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:37:41.3574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.503865ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T15:37:41.357515Z","caller":"traceutil/trace.go:171","msg":"trace[608611199] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:801; }","duration":"297.639973ms","start":"2026-09-08T15:37:41.059855Z","end":"2026-09-08T15:37:41.357495Z","steps":["trace[608611199] 'read index received' (duration: 56.80698ms)","trace[608611199] 'applied index is now lower than readState.Index' (duration: 240.831793ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:37:41.357614Z","caller":"traceutil/trace.go:171","msg":"trace[131747267] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"420.984091ms","start":"2026-09-08T15:37:40.936619Z","end":"2026-09-08T15:37:41.357603Z","steps":["trace[131747267] 'process raft request' (duration: 180.119208ms)","trace[131747267] 'compare' (duration: 240.052614ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:37:41.35768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:37:40.9366Z","time spent":"421.047012ms","remote":"127.0.0.1:52710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:37:41.357966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.122244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-08T15:37:41.358006Z","caller":"traceutil/trace.go:171","msg":"trace[1988370257] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:774; }","duration":"298.211736ms","start":"2026-09-08T15:37:41.059785Z","end":"2026-09-08T15:37:41.357996Z","steps":["trace[1988370257] 'agreement among raft nodes before linearized reading' (duration: 298.066362ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:37:41.358013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.921728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4rgm9\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-08T15:37:41.358165Z","caller":"traceutil/trace.go:171","msg":"trace[490484750] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4rgm9; range_end:; response_count:1; response_revision:774; }","duration":"255.092031ms","start":"2026-09-08T15:37:41.103008Z","end":"2026-09-08T15:37:41.3581Z","steps":["trace[490484750] 'agreement among raft nodes before linearized reading' (duration: 254.800655ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:38:12.667915Z","caller":"traceutil/trace.go:171","msg":"trace[29006318] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"143.627532ms","start":"2026-09-08T15:38:12.524243Z","end":"2026-09-08T15:38:12.66787Z","steps":["trace[29006318] 'process raft request' (duration: 143.422468ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:39:06.274142Z","caller":"traceutil/trace.go:171","msg":"trace[2077606424] linearizableReadLoop","detail":"{readStateIndex:1953; appliedIndex:1952; }","duration":"323.728508ms","start":"2026-09-08T15:39:05.95039Z","end":"2026-09-08T15:39:06.274118Z","steps":["trace[2077606424] 'read index received' (duration: 323.528134ms)","trace[2077606424] 'applied index is now lower than readState.Index' (duration: 199.464µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:39:06.274267Z","caller":"traceutil/trace.go:171","msg":"trace[1447222329] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"325.115368ms","start":"2026-09-08T15:39:05.94914Z","end":"2026-09-08T15:39:06.274256Z","steps":["trace[1447222329] 'process raft request' (duration: 324.784493ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:39:06.274521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:39:05.949129Z","time spent":"325.313862ms","remote":"127.0.0.1:52710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:39:06.274712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.226054ms","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":"warn","ts":"2026-09-08T15:39:06.27477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.371048ms","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-09-08T15:39:06.274786Z","caller":"traceutil/trace.go:171","msg":"trace[362088658] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1881; }","duration":"251.311856ms","start":"2026-09-08T15:39:06.023456Z","end":"2026-09-08T15:39:06.274768Z","steps":["trace[362088658] 'agreement among raft nodes before linearized reading' (duration: 251.185114ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:39:06.274813Z","caller":"traceutil/trace.go:171","msg":"trace[378023402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1881; }","duration":"324.433359ms","start":"2026-09-08T15:39:05.950367Z","end":"2026-09-08T15:39:06.2748Z","steps":["trace[378023402] 'agreement among raft nodes before linearized reading' (duration: 324.294167ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:39:06.27485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:39:05.950357Z","time spent":"324.48371ms","remote":"127.0.0.1:52710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-08T15:39:06.27484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.436834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:39:06.274941Z","caller":"traceutil/trace.go:171","msg":"trace[1671712379] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1881; }","duration":"206.577586ms","start":"2026-09-08T15:39:06.068338Z","end":"2026-09-08T15:39:06.274915Z","steps":["trace[1671712379] 'agreement among raft nodes before linearized reading' (duration: 206.393013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:39:06.748642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.404399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:39:06.748733Z","caller":"traceutil/trace.go:171","msg":"trace[766471394] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1883; }","duration":"205.565062ms","start":"2026-09-08T15:39:06.543145Z","end":"2026-09-08T15:39:06.74871Z","steps":["trace[766471394] 'count revisions from in-memory index tree' (duration: 205.269507ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:39:06.748862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.892774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bb61d1e8-0c6f-41c9-933e-5157e4bba9ad\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-08T15:39:06.749004Z","caller":"traceutil/trace.go:171","msg":"trace[488034903] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bb61d1e8-0c6f-41c9-933e-5157e4bba9ad; range_end:; response_count:1; response_revision:1883; }","duration":"188.103737ms","start":"2026-09-08T15:39:06.56087Z","end":"2026-09-08T15:39:06.748974Z","steps":["trace[488034903] 'range keys from in-memory index tree' (duration: 187.66576ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:39:06.749083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.881696ms","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-09-08T15:39:06.749131Z","caller":"traceutil/trace.go:171","msg":"trace[2040941610] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1883; }","duration":"205.972008ms","start":"2026-09-08T15:39:06.543145Z","end":"2026-09-08T15:39:06.749117Z","steps":["trace[2040941610] 'range keys from in-memory index tree' (duration: 205.711984ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:39:45.795385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.014909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-08T15:39:45.795527Z","caller":"traceutil/trace.go:171","msg":"trace[789837142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2145; }","duration":"271.216192ms","start":"2026-09-08T15:39:45.524282Z","end":"2026-09-08T15:39:45.795498Z","steps":["trace[789837142] 'range keys from in-memory index tree' (duration: 270.776045ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:39:45.812554Z","caller":"traceutil/trace.go:171","msg":"trace[77210311] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"155.693433ms","start":"2026-09-08T15:39:45.656834Z","end":"2026-09-08T15:39:45.812528Z","steps":["trace[77210311] 'process raft request' (duration: 155.51315ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:39:46.336303Z","caller":"traceutil/trace.go:171","msg":"trace[1992842636] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"256.153805ms","start":"2026-09-08T15:39:46.080115Z","end":"2026-09-08T15:39:46.336269Z","steps":["trace[1992842636] 'process raft request' (duration: 255.82301ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:39:46.655923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.41229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-09-08T15:39:46.65594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.994585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:39:46.656027Z","caller":"traceutil/trace.go:171","msg":"trace[2030784893] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2148; }","duration":"104.555862ms","start":"2026-09-08T15:39:46.551447Z","end":"2026-09-08T15:39:46.656003Z","steps":["trace[2030784893] 'range keys from in-memory index tree' (duration: 104.161497ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:39:46.656054Z","caller":"traceutil/trace.go:171","msg":"trace[1291128567] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2148; }","duration":"179.209448ms","start":"2026-09-08T15:39:46.476823Z","end":"2026-09-08T15:39:46.656033Z","steps":["trace[1291128567] 'range keys from in-memory index tree' (duration: 178.770412ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:39:59.36141Z","caller":"traceutil/trace.go:171","msg":"trace[164172897] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"120.891741ms","start":"2026-09-08T15:39:59.240479Z","end":"2026-09-08T15:39:59.361371Z","steps":["trace[164172897] 'process raft request' (duration: 118.59315ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:41:43.936157Z","caller":"traceutil/trace.go:171","msg":"trace[191167823] linearizableReadLoop","detail":"{readStateIndex:2987; appliedIndex:2986; }","duration":"115.730158ms","start":"2026-09-08T15:41:43.820402Z","end":"2026-09-08T15:41:43.936132Z","steps":["trace[191167823] 'read index received' (duration: 115.581025ms)","trace[191167823] 'applied index is now lower than readState.Index' (duration: 147.853µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:41:43.936398Z","caller":"traceutil/trace.go:171","msg":"trace[1508574467] transaction","detail":"{read_only:false; response_revision:2881; number_of_response:1; }","duration":"118.476692ms","start":"2026-09-08T15:41:43.817888Z","end":"2026-09-08T15:41:43.936365Z","steps":["trace[1508574467] 'process raft request' (duration: 118.092965ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:41:43.936461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.903552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T15:41:43.936513Z","caller":"traceutil/trace.go:171","msg":"trace[867432860] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:2881; }","duration":"116.146676ms","start":"2026-09-08T15:41:43.820352Z","end":"2026-09-08T15:41:43.936499Z","steps":["trace[867432860] 'agreement among raft nodes before linearized reading' (duration: 115.879231ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:41:43.957248Z","caller":"traceutil/trace.go:171","msg":"trace[455584170] transaction","detail":"{read_only:false; response_revision:2882; number_of_response:1; }","duration":"100.432697ms","start":"2026-09-08T15:41:43.85679Z","end":"2026-09-08T15:41:43.957223Z","steps":["trace[455584170] 'process raft request' (duration: 100.278154ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:41:44.491172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.741271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:41:44.491243Z","caller":"traceutil/trace.go:171","msg":"trace[1366901815] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2883; }","duration":"343.863273ms","start":"2026-09-08T15:41:44.147364Z","end":"2026-09-08T15:41:44.491227Z","steps":["trace[1366901815] 'count revisions from in-memory index tree' (duration: 343.649119ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:41:44.491274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:41:44.147344Z","time spent":"343.922865ms","remote":"127.0.0.1:52644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-09-08T15:41:44.49215Z","caller":"traceutil/trace.go:171","msg":"trace[1305435456] transaction","detail":"{read_only:false; response_revision:2884; number_of_response:1; }","duration":"169.99639ms","start":"2026-09-08T15:41:44.322143Z","end":"2026-09-08T15:41:44.492139Z","steps":["trace[1305435456] 'process raft request' (duration: 110.845998ms)","trace[1305435456] 'compare' (duration: 58.095071ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:41:54.848175Z","caller":"traceutil/trace.go:171","msg":"trace[428161026] transaction","detail":"{read_only:false; response_revision:2939; number_of_response:1; }","duration":"132.66178ms","start":"2026-09-08T15:41:54.715487Z","end":"2026-09-08T15:41:54.848149Z","steps":["trace[428161026] 'process raft request' (duration: 132.499057ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:41:55.270145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.093471ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-09-08T15:41:55.270219Z","caller":"traceutil/trace.go:171","msg":"trace[703743236] linearizableReadLoop","detail":"{readStateIndex:3048; appliedIndex:3047; }","duration":"168.310489ms","start":"2026-09-08T15:41:55.101895Z","end":"2026-09-08T15:41:55.270206Z","steps":["trace[703743236] 'read index received' (duration: 50.421µs)","trace[703743236] 'applied index is now lower than readState.Index' (duration: 168.259148ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:41:55.271191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.275727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-08T15:41:55.271273Z","caller":"traceutil/trace.go:171","msg":"trace[1173077267] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2939; }","duration":"169.407159ms","start":"2026-09-08T15:41:55.101848Z","end":"2026-09-08T15:41:55.271255Z","steps":["trace[1173077267] 'agreement among raft nodes before linearized reading' (duration: 168.548634ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:32.850068Z","caller":"traceutil/trace.go:171","msg":"trace[2097157173] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"113.954031ms","start":"2026-09-08T15:46:32.73609Z","end":"2026-09-08T15:46:32.850044Z","steps":["trace[2097157173] 'process raft request' (duration: 113.803119ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:32.889131Z","caller":"traceutil/trace.go:171","msg":"trace[282763211] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"113.085557ms","start":"2026-09-08T15:46:32.77603Z","end":"2026-09-08T15:46:32.889116Z","steps":["trace[282763211] 'process raft request' (duration: 112.6638ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:33.166855Z","caller":"traceutil/trace.go:171","msg":"trace[714970667] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"150.000317ms","start":"2026-09-08T15:46:33.016818Z","end":"2026-09-08T15:46:33.166819Z","steps":["trace[714970667] 'process raft request' (duration: 133.802589ms)","trace[714970667] 'compare' (duration: 15.820813ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:46:33.167461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.487052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-09-08T15:46:33.167501Z","caller":"traceutil/trace.go:171","msg":"trace[1010164793] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5013; }","duration":"171.582992ms","start":"2026-09-08T15:46:32.995909Z","end":"2026-09-08T15:46:33.167492Z","steps":["trace[1010164793] 'range keys from in-memory index tree' (duration: 170.437407ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:36.383977Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2844} {"level":"info","ts":"2026-09-08T15:46:36.461007Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2844,"took":"76.147565ms","hash":2236951192,"current-db-size-bytes":51916800,"current-db-size":"52 MB","current-db-size-in-use-bytes":26562560,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-08T15:46:36.461059Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2236951192,"revision":2844,"compact-revision":-1} {"level":"info","ts":"2026-09-08T15:46:41.812709Z","caller":"traceutil/trace.go:171","msg":"trace[1697964285] linearizableReadLoop","detail":"{readStateIndex:5342; appliedIndex:5341; }","duration":"435.492293ms","start":"2026-09-08T15:46:41.377188Z","end":"2026-09-08T15:46:41.812681Z","steps":["trace[1697964285] 'read index received' (duration: 419.745993ms)","trace[1697964285] 'applied index is now lower than readState.Index' (duration: 15.74224ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:46:41.813045Z","caller":"traceutil/trace.go:171","msg":"trace[1141488292] transaction","detail":"{read_only:false; response_revision:5145; number_of_response:1; }","duration":"446.758698ms","start":"2026-09-08T15:46:41.366262Z","end":"2026-09-08T15:46:41.813021Z","steps":["trace[1141488292] 'process raft request' (duration: 430.703394ms)","trace[1141488292] 'compare' (duration: 15.540786ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:46:41.813198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:41.366247Z","time spent":"446.859889ms","remote":"127.0.0.1:52710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:46:41.813522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.328515ms","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-09-08T15:46:41.813586Z","caller":"traceutil/trace.go:171","msg":"trace[1971409577] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5145; }","duration":"436.409617ms","start":"2026-09-08T15:46:41.377163Z","end":"2026-09-08T15:46:41.813573Z","steps":["trace[1971409577] 'agreement among raft nodes before linearized reading' (duration: 436.306076ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:41.813625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:41.377156Z","time spent":"436.459708ms","remote":"127.0.0.1:52710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-08T15:46:41.848477Z","caller":"traceutil/trace.go:171","msg":"trace[355041789] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"268.896179ms","start":"2026-09-08T15:46:41.579554Z","end":"2026-09-08T15:46:41.84845Z","steps":["trace[355041789] 'process raft request' (duration: 268.198999ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:41.848765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.462593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-08T15:46:41.848802Z","caller":"traceutil/trace.go:171","msg":"trace[302670812] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5147; }","duration":"114.571184ms","start":"2026-09-08T15:46:41.73422Z","end":"2026-09-08T15:46:41.848791Z","steps":["trace[302670812] 'agreement among raft nodes before linearized reading' (duration: 114.474393ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:41.848905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.919684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-08T15:46:41.848958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.853354ms","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-09-08T15:46:41.848977Z","caller":"traceutil/trace.go:171","msg":"trace[1049745888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5147; }","duration":"374.022435ms","start":"2026-09-08T15:46:41.474935Z","end":"2026-09-08T15:46:41.848957Z","steps":["trace[1049745888] 'agreement among raft nodes before linearized reading' (duration: 373.907504ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:41.848986Z","caller":"traceutil/trace.go:171","msg":"trace[1267727662] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5147; }","duration":"434.936006ms","start":"2026-09-08T15:46:41.414041Z","end":"2026-09-08T15:46:41.848977Z","steps":["trace[1267727662] 'agreement among raft nodes before linearized reading' (duration: 434.882145ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:41.849019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:41.413989Z","time spent":"435.019507ms","remote":"127.0.0.1:52710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-08T15:46:41.849022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:41.47492Z","time spent":"374.092966ms","remote":"127.0.0.1:52374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-08T15:46:41.849125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.760407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T15:46:41.849151Z","caller":"traceutil/trace.go:171","msg":"trace[1254878986] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:5147; }","duration":"231.881959ms","start":"2026-09-08T15:46:41.617261Z","end":"2026-09-08T15:46:41.849143Z","steps":["trace[1254878986] 'agreement among raft nodes before linearized reading' (duration: 231.804138ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:42.13915Z","caller":"traceutil/trace.go:171","msg":"trace[1382201555] transaction","detail":"{read_only:false; response_revision:5157; number_of_response:1; }","duration":"153.474162ms","start":"2026-09-08T15:46:41.985631Z","end":"2026-09-08T15:46:42.139105Z","steps":["trace[1382201555] 'process raft request' (duration: 91.265884ms)","trace[1382201555] 'compare' (duration: 62.025786ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:46:46.105936Z","caller":"traceutil/trace.go:171","msg":"trace[1796584213] linearizableReadLoop","detail":"{readStateIndex:5454; appliedIndex:5451; }","duration":"205.694032ms","start":"2026-09-08T15:46:45.900218Z","end":"2026-09-08T15:46:46.105912Z","steps":["trace[1796584213] 'read index received' (duration: 187.463916ms)","trace[1796584213] 'applied index is now lower than readState.Index' (duration: 18.229116ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:46:46.106064Z","caller":"traceutil/trace.go:171","msg":"trace[326695319] transaction","detail":"{read_only:false; response_revision:5254; number_of_response:1; }","duration":"212.068434ms","start":"2026-09-08T15:46:45.893983Z","end":"2026-09-08T15:46:46.106051Z","steps":["trace[326695319] 'process raft request' (duration: 193.675756ms)","trace[326695319] 'compare' (duration: 17.83922ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:46:46.106458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.480883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:46:46.106516Z","caller":"traceutil/trace.go:171","msg":"trace[815611129] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:5256; }","duration":"145.549314ms","start":"2026-09-08T15:46:45.960952Z","end":"2026-09-08T15:46:46.106501Z","steps":["trace[815611129] 'agreement among raft nodes before linearized reading' (duration: 145.455723ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:46.106581Z","caller":"traceutil/trace.go:171","msg":"trace[548845047] transaction","detail":"{read_only:false; response_revision:5256; number_of_response:1; }","duration":"210.936838ms","start":"2026-09-08T15:46:45.895629Z","end":"2026-09-08T15:46:46.106566Z","steps":["trace[548845047] 'process raft request' (duration: 210.243868ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:46.10654Z","caller":"traceutil/trace.go:171","msg":"trace[1807347413] transaction","detail":"{read_only:false; response_revision:5255; number_of_response:1; }","duration":"210.960119ms","start":"2026-09-08T15:46:45.895531Z","end":"2026-09-08T15:46:46.106491Z","steps":["trace[1807347413] 'process raft request' (duration: 210.237758ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:46.106658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.409903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e4b4ad7c-bb3c-482b-807f-42c4c993f678\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-08T15:46:46.106762Z","caller":"traceutil/trace.go:171","msg":"trace[446858678] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e4b4ad7c-bb3c-482b-807f-42c4c993f678; range_end:; response_count:1; response_revision:5256; }","duration":"206.542805ms","start":"2026-09-08T15:46:45.900191Z","end":"2026-09-08T15:46:46.106733Z","steps":["trace[446858678] 'agreement among raft nodes before linearized reading' (duration: 206.17974ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:46.360384Z","caller":"traceutil/trace.go:171","msg":"trace[525080215] linearizableReadLoop","detail":"{readStateIndex:5455; appliedIndex:5454; }","duration":"222.321714ms","start":"2026-09-08T15:46:46.138034Z","end":"2026-09-08T15:46:46.360356Z","steps":["trace[525080215] 'read index received' (duration: 140.057974ms)","trace[525080215] 'applied index is now lower than readState.Index' (duration: 82.26273ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:46:46.360633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.813309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18d36311cd6c195d\" ","response":"range_response_count:1 size:1012"} {"level":"info","ts":"2026-09-08T15:46:46.360543Z","caller":"traceutil/trace.go:171","msg":"trace[1753371901] transaction","detail":"{read_only:false; response_revision:5257; number_of_response:1; }","duration":"245.668894ms","start":"2026-09-08T15:46:46.114765Z","end":"2026-09-08T15:46:46.360434Z","steps":["trace[1753371901] 'process raft request' (duration: 163.368043ms)","trace[1753371901] 'compare' (duration: 82.093338ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:46:46.360633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.581077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e4b4ad7c-bb3c-482b-807f-42c4c993f678\" ","response":"range_response_count:1 size:3762"} {"level":"info","ts":"2026-09-08T15:46:46.360675Z","caller":"traceutil/trace.go:171","msg":"trace[1896777749] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18d36311cd6c195d; range_end:; response_count:1; response_revision:5257; }","duration":"130.901489ms","start":"2026-09-08T15:46:46.229759Z","end":"2026-09-08T15:46:46.360661Z","steps":["trace[1896777749] 'agreement among raft nodes before linearized reading' (duration: 130.731357ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:46.360794Z","caller":"traceutil/trace.go:171","msg":"trace[703594552] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e4b4ad7c-bb3c-482b-807f-42c4c993f678; range_end:; response_count:1; response_revision:5257; }","duration":"222.78572ms","start":"2026-09-08T15:46:46.137989Z","end":"2026-09-08T15:46:46.360775Z","steps":["trace[703594552] 'agreement among raft nodes before linearized reading' (duration: 222.563807ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:47:10.612613Z","caller":"traceutil/trace.go:171","msg":"trace[950683329] transaction","detail":"{read_only:false; response_revision:5492; number_of_response:1; }","duration":"116.062163ms","start":"2026-09-08T15:47:10.496518Z","end":"2026-09-08T15:47:10.612581Z","steps":["trace[950683329] 'process raft request' (duration: 69.362876ms)","trace[950683329] 'compare' (duration: 46.589545ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:47:10.61656Z","caller":"traceutil/trace.go:171","msg":"trace[1985078504] transaction","detail":"{read_only:false; response_revision:5493; number_of_response:1; }","duration":"119.994729ms","start":"2026-09-08T15:47:10.496542Z","end":"2026-09-08T15:47:10.616537Z","steps":["trace[1985078504] 'process raft request' (duration: 119.33148ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:47:10.617123Z","caller":"traceutil/trace.go:171","msg":"trace[1343967694] transaction","detail":"{read_only:false; response_revision:5495; number_of_response:1; }","duration":"108.513363ms","start":"2026-09-08T15:47:10.508353Z","end":"2026-09-08T15:47:10.616866Z","steps":["trace[1343967694] 'process raft request' (duration: 108.102167ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:47:10.617331Z","caller":"traceutil/trace.go:171","msg":"trace[1129929643] transaction","detail":"{read_only:false; response_revision:5494; number_of_response:1; }","duration":"119.802788ms","start":"2026-09-08T15:47:10.497466Z","end":"2026-09-08T15:47:10.617269Z","steps":["trace[1129929643] 'process raft request' (duration: 118.916175ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:51:36.394223Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5091} {"level":"info","ts":"2026-09-08T15:51:36.47997Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5091,"took":"84.14453ms","hash":3660673595,"current-db-size-bytes":51916800,"current-db-size":"52 MB","current-db-size-in-use-bytes":19628032,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-09-08T15:51:36.480043Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3660673595,"revision":5091,"compact-revision":2844}