{"level":"warn","ts":"2026-08-24T20:34:16.322825Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-24T20:34:16.322908Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.117: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.117:2380","--initial-cluster=instance=https://199.19.213.117:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.117:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.117: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-08-24T20:34:16.322977Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-24T20:34:16.32299Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.117:2380"]} {"level":"info","ts":"2026-08-24T20:34:16.323012Z","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-08-24T20:34:16.323696Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.117:2379"]} {"level":"info","ts":"2026-08-24T20:34:16.323769Z","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.117:2380"],"listen-peer-urls":["https://199.19.213.117:2380"],"advertise-client-urls":["https://199.19.213.117:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.117:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.117: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-08-24T20:34:16.328677Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.69791ms"} {"level":"info","ts":"2026-08-24T20:34:16.334657Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f9f905057b5b268","cluster-id":"293172f52aeb3f03"} {"level":"info","ts":"2026-08-24T20:34:16.334718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 switched to configuration voters=()"} {"level":"info","ts":"2026-08-24T20:34:16.334736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became follower at term 0"} {"level":"info","ts":"2026-08-24T20:34:16.334749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f9f905057b5b268 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-24T20:34:16.334762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became follower at term 1"} {"level":"info","ts":"2026-08-24T20:34:16.334806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 switched to configuration voters=(6890384629643457128)"} {"level":"warn","ts":"2026-08-24T20:34:16.340865Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-24T20:34:16.342023Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-24T20:34:16.343118Z","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-08-24T20:34:16.345601Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f9f905057b5b268","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-24T20:34:16.346026Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f9f905057b5b268","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-24T20:34:16.346138Z","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-08-24T20:34:16.348742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 switched to configuration voters=(6890384629643457128)"} {"level":"info","ts":"2026-08-24T20:34:16.348778Z","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-08-24T20:34:16.348805Z","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-08-24T20:34:16.348928Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"293172f52aeb3f03","local-member-id":"5f9f905057b5b268","added-peer-id":"5f9f905057b5b268","added-peer-peer-urls":["https://199.19.213.117:2380"]} {"level":"info","ts":"2026-08-24T20:34:16.351441Z","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-08-24T20:34:16.351621Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f9f905057b5b268","initial-advertise-peer-urls":["https://199.19.213.117:2380"],"listen-peer-urls":["https://199.19.213.117:2380"],"advertise-client-urls":["https://199.19.213.117:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.117:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-24T20:34:16.351658Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-24T20:34:16.352176Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.117:2380"} {"level":"info","ts":"2026-08-24T20:34:16.352209Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.117:2380"} {"level":"info","ts":"2026-08-24T20:34:16.435928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 is starting a new election at term 1"} {"level":"info","ts":"2026-08-24T20:34:16.435974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-24T20:34:16.436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 received MsgPreVoteResp from 5f9f905057b5b268 at term 1"} {"level":"info","ts":"2026-08-24T20:34:16.436015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became candidate at term 2"} {"level":"info","ts":"2026-08-24T20:34:16.436022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 received MsgVoteResp from 5f9f905057b5b268 at term 2"} {"level":"info","ts":"2026-08-24T20:34:16.43604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became leader at term 2"} {"level":"info","ts":"2026-08-24T20:34:16.436049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f9f905057b5b268 elected leader 5f9f905057b5b268 at term 2"} {"level":"info","ts":"2026-08-24T20:34:16.436963Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f9f905057b5b268","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.117:2379]}","request-path":"/0/members/5f9f905057b5b268/attributes","cluster-id":"293172f52aeb3f03","publish-timeout":"7s"} {"level":"info","ts":"2026-08-24T20:34:16.437088Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T20:34:16.437146Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T20:34:16.437151Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T20:34:16.437441Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-24T20:34:16.437498Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-24T20:34:16.438121Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"293172f52aeb3f03","local-member-id":"5f9f905057b5b268","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T20:34:16.438258Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T20:34:16.438307Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T20:34:16.439025Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.117:2379"} {"level":"info","ts":"2026-08-24T20:34:16.439888Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-24T20:35:29.834381Z","caller":"traceutil/trace.go:171","msg":"trace[1768274490] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"310.441706ms","start":"2026-08-24T20:35:29.523908Z","end":"2026-08-24T20:35:29.834349Z","steps":["trace[1768274490] 'process raft request' (duration: 305.676147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:35:29.835086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:35:29.523873Z","time spent":"310.596179ms","remote":"127.0.0.1:36222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-24T20:35:30.032187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.733153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T20:35:30.032441Z","caller":"traceutil/trace.go:171","msg":"trace[547844922] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:651; }","duration":"130.04098ms","start":"2026-08-24T20:35:29.902369Z","end":"2026-08-24T20:35:30.03241Z","steps":["trace[547844922] 'range keys from in-memory index tree' (duration: 129.598369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:35:30.619943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.670069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T20:35:30.620107Z","caller":"traceutil/trace.go:171","msg":"trace[628824697] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"504.113763ms","start":"2026-08-24T20:35:30.115972Z","end":"2026-08-24T20:35:30.620086Z","steps":["trace[628824697] 'read index received' (duration: 39.847961ms)","trace[628824697] 'applied index is now lower than readState.Index' (duration: 464.263762ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T20:35:30.620215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.238336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-08-24T20:35:30.620245Z","caller":"traceutil/trace.go:171","msg":"trace[1335050854] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:653; }","duration":"504.296146ms","start":"2026-08-24T20:35:30.115939Z","end":"2026-08-24T20:35:30.620235Z","steps":["trace[1335050854] 'agreement among raft nodes before linearized reading' (duration: 504.209354ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:35:30.620292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:35:30.115927Z","time spent":"504.356717ms","remote":"127.0.0.1:36292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-08-24T20:35:30.620524Z","caller":"traceutil/trace.go:171","msg":"trace[1291719602] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"509.986308ms","start":"2026-08-24T20:35:30.110226Z","end":"2026-08-24T20:35:30.620212Z","steps":["trace[1291719602] 'process raft request' (duration: 45.566194ms)","trace[1291719602] 'compare' (duration: 462.466896ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T20:35:30.6209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:35:30.110201Z","time spent":"510.57857ms","remote":"127.0.0.1:36300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T20:35:30.699551Z","caller":"traceutil/trace.go:171","msg":"trace[1769186747] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"448.434892ms","start":"2026-08-24T20:35:30.251102Z","end":"2026-08-24T20:35:30.699537Z","steps":["trace[1769186747] 'process raft request' (duration: 448.345999ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:35:30.699656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:35:30.251069Z","time spent":"448.522633ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T20:35:30.766845Z","caller":"traceutil/trace.go:171","msg":"trace[549222918] linearizableReadLoop","detail":"{readStateIndex:690; appliedIndex:689; }","duration":"143.665226ms","start":"2026-08-24T20:35:30.623147Z","end":"2026-08-24T20:35:30.766812Z","steps":["trace[549222918] 'read index received' (duration: 76.390338ms)","trace[549222918] 'applied index is now lower than readState.Index' (duration: 67.273978ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:35:30.766955Z","caller":"traceutil/trace.go:171","msg":"trace[552953228] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"306.597061ms","start":"2026-08-24T20:35:30.460335Z","end":"2026-08-24T20:35:30.766932Z","steps":["trace[552953228] 'process raft request' (duration: 301.642423ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:35:30.767193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.017274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-24T20:35:30.767261Z","caller":"traceutil/trace.go:171","msg":"trace[124109716] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:655; }","duration":"144.178097ms","start":"2026-08-24T20:35:30.623067Z","end":"2026-08-24T20:35:30.767245Z","steps":["trace[124109716] 'agreement among raft nodes before linearized reading' (duration: 143.950262ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:35:30.767296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:35:30.460312Z","time spent":"306.692863ms","remote":"127.0.0.1:36222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T20:35:30.768204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.295473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-24T20:35:30.774636Z","caller":"traceutil/trace.go:171","msg":"trace[651681288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:655; }","duration":"134.405964ms","start":"2026-08-24T20:35:30.633848Z","end":"2026-08-24T20:35:30.768254Z","steps":["trace[651681288] 'agreement among raft nodes before linearized reading' (duration: 133.203351ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:35:32.535879Z","caller":"traceutil/trace.go:171","msg":"trace[1165299652] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"108.215531ms","start":"2026-08-24T20:35:32.427641Z","end":"2026-08-24T20:35:32.535857Z","steps":["trace[1165299652] 'process raft request' (duration: 108.104489ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:35:45.041821Z","caller":"traceutil/trace.go:171","msg":"trace[258704649] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"109.191169ms","start":"2026-08-24T20:35:44.932609Z","end":"2026-08-24T20:35:45.0418Z","steps":["trace[258704649] 'process raft request' (duration: 109.027985ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:35:45.20802Z","caller":"traceutil/trace.go:171","msg":"trace[1841358075] linearizableReadLoop","detail":"{readStateIndex:864; appliedIndex:863; }","duration":"179.966732ms","start":"2026-08-24T20:35:45.02803Z","end":"2026-08-24T20:35:45.207997Z","steps":["trace[1841358075] 'read index received' (duration: 13.779379ms)","trace[1841358075] 'applied index is now lower than readState.Index' (duration: 166.186313ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:35:45.208204Z","caller":"traceutil/trace.go:171","msg":"trace[1813437699] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"274.435668ms","start":"2026-08-24T20:35:44.933676Z","end":"2026-08-24T20:35:45.208112Z","steps":["trace[1813437699] 'process raft request' (duration: 274.185797ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:35:45.208264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.175314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T20:35:45.208319Z","caller":"traceutil/trace.go:171","msg":"trace[125380473] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:826; }","duration":"180.304051ms","start":"2026-08-24T20:35:45.028002Z","end":"2026-08-24T20:35:45.208306Z","steps":["trace[125380473] 'agreement among raft nodes before linearized reading' (duration: 180.121457ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:35:45.208487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.470896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T20:35:45.20858Z","caller":"traceutil/trace.go:171","msg":"trace[1744138373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:826; }","duration":"106.594981ms","start":"2026-08-24T20:35:45.101972Z","end":"2026-08-24T20:35:45.208567Z","steps":["trace[1744138373] 'agreement among raft nodes before linearized reading' (duration: 106.371429ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:01.820805Z","caller":"traceutil/trace.go:171","msg":"trace[1174709529] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"203.783714ms","start":"2026-08-24T20:37:01.616987Z","end":"2026-08-24T20:37:01.820771Z","steps":["trace[1174709529] 'process raft request' (duration: 203.581411ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:02.162947Z","caller":"traceutil/trace.go:171","msg":"trace[1604442470] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"323.437128ms","start":"2026-08-24T20:37:01.83943Z","end":"2026-08-24T20:37:02.162868Z","steps":["trace[1604442470] 'process raft request' (duration: 323.362557ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:02.162962Z","caller":"traceutil/trace.go:171","msg":"trace[66786540] linearizableReadLoop","detail":"{readStateIndex:1968; appliedIndex:1967; }","duration":"474.834056ms","start":"2026-08-24T20:37:01.688083Z","end":"2026-08-24T20:37:02.162917Z","steps":["trace[66786540] 'read index received' (duration: 133.123663ms)","trace[66786540] 'applied index is now lower than readState.Index' (duration: 341.705483ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:37:02.163053Z","caller":"traceutil/trace.go:171","msg":"trace[1378987072] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"536.755501ms","start":"2026-08-24T20:37:01.626242Z","end":"2026-08-24T20:37:02.163014Z","steps":["trace[1378987072] 'process raft request' (duration: 478.617111ms)","trace[1378987072] 'compare' (duration: 57.758144ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T20:37:02.163213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:01.839405Z","time spent":"323.623572ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T20:37:02.163219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.13392ms","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-08-24T20:37:02.163297Z","caller":"traceutil/trace.go:171","msg":"trace[740850308] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1890; }","duration":"475.275352ms","start":"2026-08-24T20:37:01.687999Z","end":"2026-08-24T20:37:02.163274Z","steps":["trace[740850308] 'agreement among raft nodes before linearized reading' (duration: 475.080949ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.163334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:01.687971Z","time spent":"475.355073ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-24T20:37:02.163629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:01.626229Z","time spent":"536.914882ms","remote":"127.0.0.1:36300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T20:37:02.165642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.816728ms","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-08-24T20:37:02.165708Z","caller":"traceutil/trace.go:171","msg":"trace[712776438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1890; }","duration":"389.982231ms","start":"2026-08-24T20:37:01.77571Z","end":"2026-08-24T20:37:02.165693Z","steps":["trace[712776438] 'agreement among raft nodes before linearized reading' (duration: 389.182719ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.165753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:01.775683Z","time spent":"390.058773ms","remote":"127.0.0.1:36394","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-08-24T20:37:02.165886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.565395ms","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-08-24T20:37:02.165957Z","caller":"traceutil/trace.go:171","msg":"trace[1576851011] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1890; }","duration":"162.667746ms","start":"2026-08-24T20:37:02.003267Z","end":"2026-08-24T20:37:02.165935Z","steps":["trace[1576851011] 'agreement among raft nodes before linearized reading' (duration: 162.427992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.166131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.620503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-08-24T20:37:02.166196Z","caller":"traceutil/trace.go:171","msg":"trace[2114825111] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1890; }","duration":"247.707785ms","start":"2026-08-24T20:37:01.91846Z","end":"2026-08-24T20:37:02.166168Z","steps":["trace[2114825111] 'agreement among raft nodes before linearized reading' (duration: 247.520802ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.520246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.95297ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T20:37:02.520566Z","caller":"traceutil/trace.go:171","msg":"trace[594629777] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"348.635698ms","start":"2026-08-24T20:37:02.171853Z","end":"2026-08-24T20:37:02.520489Z","steps":["trace[594629777] 'process raft request' (duration: 127.331794ms)","trace[594629777] 'compare' (duration: 220.714017ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:37:02.520791Z","caller":"traceutil/trace.go:171","msg":"trace[302860279] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"143.783008ms","start":"2026-08-24T20:37:02.376989Z","end":"2026-08-24T20:37:02.520772Z","steps":["trace[302860279] 'process raft request' (duration: 143.740047ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:02.520848Z","caller":"traceutil/trace.go:171","msg":"trace[355849391] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"347.397472ms","start":"2026-08-24T20:37:02.173414Z","end":"2026-08-24T20:37:02.520811Z","steps":["trace[355849391] 'process raft request' (duration: 347.105727ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.520914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:02.17184Z","time spent":"348.921844ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T20:37:02.521059Z","caller":"traceutil/trace.go:171","msg":"trace[1582097552] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1969; }","duration":"347.737156ms","start":"2026-08-24T20:37:02.173309Z","end":"2026-08-24T20:37:02.521046Z","steps":["trace[1582097552] 'read index received' (duration: 52.768872ms)","trace[1582097552] 'applied index is now lower than readState.Index' (duration: 294.966274ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:37:02.521171Z","caller":"traceutil/trace.go:171","msg":"trace[1905448495] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"150.450715ms","start":"2026-08-24T20:37:02.370707Z","end":"2026-08-24T20:37:02.521158Z","steps":["trace[1905448495] 'process raft request' (duration: 149.983979ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.521243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:02.173407Z","time spent":"347.595325ms","remote":"127.0.0.1:36408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T20:37:02.521312Z","caller":"traceutil/trace.go:171","msg":"trace[1961549806] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"346.325924ms","start":"2026-08-24T20:37:02.174875Z","end":"2026-08-24T20:37:02.521201Z","steps":["trace[1961549806] 'process raft request' (duration: 345.758386ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.521473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.154542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10985"} {"level":"info","ts":"2026-08-24T20:37:02.521509Z","caller":"traceutil/trace.go:171","msg":"trace[421519963] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1899; }","duration":"348.204132ms","start":"2026-08-24T20:37:02.173294Z","end":"2026-08-24T20:37:02.521498Z","steps":["trace[421519963] 'agreement among raft nodes before linearized reading' (duration: 348.03421ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.52155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:02.173289Z","time spent":"348.251753ms","remote":"127.0.0.1:36300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":11007,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"warn","ts":"2026-08-24T20:37:02.521602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.387818ms","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-08-24T20:37:02.5217Z","caller":"traceutil/trace.go:171","msg":"trace[657183048] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1899; }","duration":"340.526028ms","start":"2026-08-24T20:37:02.181152Z","end":"2026-08-24T20:37:02.521678Z","steps":["trace[657183048] 'agreement among raft nodes before linearized reading' (duration: 340.362036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.521749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:02.181141Z","time spent":"340.597159ms","remote":"127.0.0.1:58074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"info","ts":"2026-08-24T20:37:02.521891Z","caller":"traceutil/trace.go:171","msg":"trace[857205271] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"349.983508ms","start":"2026-08-24T20:37:02.171891Z","end":"2026-08-24T20:37:02.521874Z","steps":["trace[857205271] 'process raft request' (duration: 348.478186ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:02.52196Z","caller":"traceutil/trace.go:171","msg":"trace[253544101] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"348.827103ms","start":"2026-08-24T20:37:02.173115Z","end":"2026-08-24T20:37:02.521943Z","steps":["trace[253544101] 'process raft request' (duration: 347.3621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.522006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:02.171876Z","time spent":"350.058821ms","remote":"127.0.0.1:36292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T20:37:02.522095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:02.173102Z","time spent":"348.909883ms","remote":"127.0.0.1:36408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T20:37:02.522326Z","caller":"traceutil/trace.go:171","msg":"trace[958329262] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"348.623658ms","start":"2026-08-24T20:37:02.173685Z","end":"2026-08-24T20:37:02.522309Z","steps":["trace[958329262] 'process raft request' (duration: 346.889213ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:02.522432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:02.173677Z","time spent":"348.69141ms","remote":"127.0.0.1:36394","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-08-24T20:37:02.521747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:02.174865Z","time spent":"346.621299ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T20:37:14.37522Z","caller":"traceutil/trace.go:171","msg":"trace[534772019] linearizableReadLoop","detail":"{readStateIndex:2079; appliedIndex:2078; }","duration":"129.532578ms","start":"2026-08-24T20:37:14.245665Z","end":"2026-08-24T20:37:14.375198Z","steps":["trace[534772019] 'read index received' (duration: 129.322304ms)","trace[534772019] 'applied index is now lower than readState.Index' (duration: 209.404µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:37:14.375272Z","caller":"traceutil/trace.go:171","msg":"trace[963258925] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"162.324835ms","start":"2026-08-24T20:37:14.212917Z","end":"2026-08-24T20:37:14.375241Z","steps":["trace[963258925] 'process raft request' (duration: 162.129561ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:14.375433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.749811ms","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-08-24T20:37:14.375477Z","caller":"traceutil/trace.go:171","msg":"trace[1265227071] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1997; }","duration":"129.839302ms","start":"2026-08-24T20:37:14.245625Z","end":"2026-08-24T20:37:14.375465Z","steps":["trace[1265227071] 'agreement among raft nodes before linearized reading' (duration: 129.660499ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:17.427873Z","caller":"traceutil/trace.go:171","msg":"trace[1857358739] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"409.595062ms","start":"2026-08-24T20:37:17.01826Z","end":"2026-08-24T20:37:17.427855Z","steps":["trace[1857358739] 'process raft request' (duration: 409.159554ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:17.428005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:17.018247Z","time spent":"409.683834ms","remote":"127.0.0.1:36300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5586,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T20:37:17.427562Z","caller":"traceutil/trace.go:171","msg":"trace[1637596537] linearizableReadLoop","detail":"{readStateIndex:2099; appliedIndex:2098; }","duration":"325.103272ms","start":"2026-08-24T20:37:17.10244Z","end":"2026-08-24T20:37:17.427543Z","steps":["trace[1637596537] 'read index received' (duration: 324.933108ms)","trace[1637596537] 'applied index is now lower than readState.Index' (duration: 169.474µs)"],"step_count":2} {"level":"warn","ts":"2026-08-24T20:37:17.428461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.00943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T20:37:17.428518Z","caller":"traceutil/trace.go:171","msg":"trace[319905987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2016; }","duration":"326.097421ms","start":"2026-08-24T20:37:17.102405Z","end":"2026-08-24T20:37:17.428502Z","steps":["trace[319905987] 'agreement among raft nodes before linearized reading' (duration: 326.008119ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:17.428557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T20:37:17.102391Z","time spent":"326.156233ms","remote":"127.0.0.1:36162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-24T20:37:36.635714Z","caller":"traceutil/trace.go:171","msg":"trace[1430573348] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"265.101655ms","start":"2026-08-24T20:37:36.370587Z","end":"2026-08-24T20:37:36.635689Z","steps":["trace[1430573348] 'process raft request' (duration: 264.968022ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:36.636259Z","caller":"traceutil/trace.go:171","msg":"trace[301252214] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2219; }","duration":"255.102386ms","start":"2026-08-24T20:37:36.381139Z","end":"2026-08-24T20:37:36.636241Z","steps":["trace[301252214] 'read index received' (duration: 255.095366ms)","trace[301252214] 'applied index is now lower than readState.Index' (duration: 5.58µs)"],"step_count":2} {"level":"warn","ts":"2026-08-24T20:37:36.63643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.26599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T20:37:36.636496Z","caller":"traceutil/trace.go:171","msg":"trace[309491329] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2131; }","duration":"255.381262ms","start":"2026-08-24T20:37:36.381096Z","end":"2026-08-24T20:37:36.636477Z","steps":["trace[309491329] 'agreement among raft nodes before linearized reading' (duration: 255.259489ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:36.692001Z","caller":"traceutil/trace.go:171","msg":"trace[951911078] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"236.690347ms","start":"2026-08-24T20:37:36.455288Z","end":"2026-08-24T20:37:36.691978Z","steps":["trace[951911078] 'process raft request' (duration: 236.554733ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:36.692213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.692409ms","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-08-24T20:37:36.692284Z","caller":"traceutil/trace.go:171","msg":"trace[1218754744] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2132; }","duration":"116.801341ms","start":"2026-08-24T20:37:36.575467Z","end":"2026-08-24T20:37:36.692268Z","steps":["trace[1218754744] 'agreement among raft nodes before linearized reading' (duration: 116.579336ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:36.765203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.772432ms","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-08-24T20:37:36.76526Z","caller":"traceutil/trace.go:171","msg":"trace[36648533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2133; }","duration":"106.866354ms","start":"2026-08-24T20:37:36.658381Z","end":"2026-08-24T20:37:36.765247Z","steps":["trace[36648533] 'agreement among raft nodes before linearized reading' (duration: 106.695ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:36.765428Z","caller":"traceutil/trace.go:171","msg":"trace[801750799] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"115.125901ms","start":"2026-08-24T20:37:36.650292Z","end":"2026-08-24T20:37:36.765418Z","steps":["trace[801750799] 'process raft request' (duration: 60.083695ms)","trace[801750799] 'compare' (duration: 54.553204ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:37:36.99111Z","caller":"traceutil/trace.go:171","msg":"trace[1199203155] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"220.781115ms","start":"2026-08-24T20:37:36.770298Z","end":"2026-08-24T20:37:36.991079Z","steps":["trace[1199203155] 'process raft request' (duration: 220.56423ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:36.991141Z","caller":"traceutil/trace.go:171","msg":"trace[579595664] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"220.474858ms","start":"2026-08-24T20:37:36.77065Z","end":"2026-08-24T20:37:36.991124Z","steps":["trace[579595664] 'process raft request' (duration: 220.245482ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:36.991309Z","caller":"traceutil/trace.go:171","msg":"trace[719434223] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"221.747249ms","start":"2026-08-24T20:37:36.769549Z","end":"2026-08-24T20:37:36.991296Z","steps":["trace[719434223] 'process raft request' (duration: 158.392696ms)","trace[719434223] 'compare' (duration: 62.80991ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:37:37.213253Z","caller":"traceutil/trace.go:171","msg":"trace[559502981] linearizableReadLoop","detail":"{readStateIndex:2226; appliedIndex:2225; }","duration":"111.963508ms","start":"2026-08-24T20:37:37.101253Z","end":"2026-08-24T20:37:37.213216Z","steps":["trace[559502981] 'read index received' (duration: 110.611505ms)","trace[559502981] 'applied index is now lower than readState.Index' (duration: 1.350963ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:37:37.213351Z","caller":"traceutil/trace.go:171","msg":"trace[1021485531] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"217.617832ms","start":"2026-08-24T20:37:36.995717Z","end":"2026-08-24T20:37:37.213334Z","steps":["trace[1021485531] 'process raft request' (duration: 216.231709ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:37:37.213573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.291865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T20:37:37.213588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.457795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T20:37:37.213628Z","caller":"traceutil/trace.go:171","msg":"trace[1962815962] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2138; }","duration":"112.405208ms","start":"2026-08-24T20:37:37.101207Z","end":"2026-08-24T20:37:37.213613Z","steps":["trace[1962815962] 'agreement among raft nodes before linearized reading' (duration: 112.147882ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:37:37.213748Z","caller":"traceutil/trace.go:171","msg":"trace[439833834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2138; }","duration":"111.63277ms","start":"2026-08-24T20:37:37.102095Z","end":"2026-08-24T20:37:37.213728Z","steps":["trace[439833834] 'agreement among raft nodes before linearized reading' (duration: 111.372624ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:42:45.418542Z","caller":"traceutil/trace.go:171","msg":"trace[267484938] linearizableReadLoop","detail":"{readStateIndex:4832; appliedIndex:4830; }","duration":"212.816473ms","start":"2026-08-24T20:42:45.205692Z","end":"2026-08-24T20:42:45.418509Z","steps":["trace[267484938] 'read index received' (duration: 805.242µs)","trace[267484938] 'applied index is now lower than readState.Index' (duration: 212.008341ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:42:45.418896Z","caller":"traceutil/trace.go:171","msg":"trace[219401523] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"228.231934ms","start":"2026-08-24T20:42:45.190332Z","end":"2026-08-24T20:42:45.418564Z","steps":["trace[219401523] 'process raft request' (duration: 226.401714ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:42:45.419542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.82842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-24T20:42:45.419603Z","caller":"traceutil/trace.go:171","msg":"trace[1450812845] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4652; }","duration":"213.925922ms","start":"2026-08-24T20:42:45.20566Z","end":"2026-08-24T20:42:45.419586Z","steps":["trace[1450812845] 'agreement among raft nodes before linearized reading' (duration: 212.970166ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:42:48.512605Z","caller":"traceutil/trace.go:171","msg":"trace[286419356] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"141.965165ms","start":"2026-08-24T20:42:48.37062Z","end":"2026-08-24T20:42:48.512585Z","steps":["trace[286419356] 'process raft request' (duration: 141.601405ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:42:58.666213Z","caller":"traceutil/trace.go:171","msg":"trace[289188217] linearizableReadLoop","detail":"{readStateIndex:5016; appliedIndex:5015; }","duration":"156.032835ms","start":"2026-08-24T20:42:58.510155Z","end":"2026-08-24T20:42:58.666188Z","steps":["trace[289188217] 'read index received' (duration: 155.81819ms)","trace[289188217] 'applied index is now lower than readState.Index' (duration: 213.595µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T20:42:58.66628Z","caller":"traceutil/trace.go:171","msg":"trace[194755890] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"160.309544ms","start":"2026-08-24T20:42:58.505939Z","end":"2026-08-24T20:42:58.666248Z","steps":["trace[194755890] 'process raft request' (duration: 160.056437ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:42:58.666434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.265131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-24T20:42:58.666517Z","caller":"traceutil/trace.go:171","msg":"trace[350663988] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4829; }","duration":"156.391365ms","start":"2026-08-24T20:42:58.51011Z","end":"2026-08-24T20:42:58.666502Z","steps":["trace[350663988] 'agreement among raft nodes before linearized reading' (duration: 156.21461ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T20:42:58.666674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.541535ms","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-08-24T20:42:58.666768Z","caller":"traceutil/trace.go:171","msg":"trace[2028656636] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4829; }","duration":"109.683238ms","start":"2026-08-24T20:42:58.55707Z","end":"2026-08-24T20:42:58.666753Z","steps":["trace[2028656636] 'agreement among raft nodes before linearized reading' (duration: 109.345048ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T20:44:17.124856Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2782} {"level":"info","ts":"2026-08-24T20:44:17.227496Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2782,"took":"101.46967ms","hash":3911776563,"current-db-size-bytes":54038528,"current-db-size":"54 MB","current-db-size-in-use-bytes":29376512,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-24T20:44:17.227552Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3911776563,"revision":2782,"compact-revision":-1} {"level":"info","ts":"2026-08-24T20:49:17.133925Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5480} {"level":"info","ts":"2026-08-24T20:49:17.208551Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5480,"took":"73.310563ms","hash":142858384,"current-db-size-bytes":54038528,"current-db-size":"54 MB","current-db-size-in-use-bytes":18243584,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-24T20:49:17.208621Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":142858384,"revision":5480,"compact-revision":2782}