{"level":"warn","ts":"2026-05-12T11:23:54.022603Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-12T11:23:54.022744Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.203: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.203:2380","--initial-cluster=instance=https://199.19.213.203:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.203:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.203:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-12T11:23:54.022822Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-12T11:23:54.022832Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.203:2380"]} {"level":"info","ts":"2026-05-12T11:23:54.022848Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-12T11:23:54.023517Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.203:2379"]} {"level":"info","ts":"2026-05-12T11:23:54.023589Z","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.203:2380"],"listen-peer-urls":["https://199.19.213.203:2380"],"advertise-client-urls":["https://199.19.213.203:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.203:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.203:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-12T11:23:54.031377Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.346245ms"} {"level":"info","ts":"2026-05-12T11:23:54.040556Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b5a1dacc8ba86a4f","cluster-id":"a3ec0b489c26f222"} {"level":"info","ts":"2026-05-12T11:23:54.04071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f switched to configuration voters=()"} {"level":"info","ts":"2026-05-12T11:23:54.040765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f became follower at term 0"} {"level":"info","ts":"2026-05-12T11:23:54.040851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b5a1dacc8ba86a4f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-12T11:23:54.040878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f became follower at term 1"} {"level":"info","ts":"2026-05-12T11:23:54.040934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f switched to configuration voters=(13087982564166625871)"} {"level":"warn","ts":"2026-05-12T11:23:54.046647Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-12T11:23:54.047979Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-12T11:23:54.048885Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-12T11:23:54.051445Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b5a1dacc8ba86a4f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-12T11:23:54.051599Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-12T11:23:54.051726Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-12T11:23:54.051745Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-12T11:23:54.051656Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b5a1dacc8ba86a4f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-12T11:23:54.056137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f switched to configuration voters=(13087982564166625871)"} {"level":"info","ts":"2026-05-12T11:23:54.056333Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a3ec0b489c26f222","local-member-id":"b5a1dacc8ba86a4f","added-peer-id":"b5a1dacc8ba86a4f","added-peer-peer-urls":["https://199.19.213.203:2380"]} {"level":"info","ts":"2026-05-12T11:23:54.057329Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-12T11:23:54.0574Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.203:2380"} {"level":"info","ts":"2026-05-12T11:23:54.057445Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.203:2380"} {"level":"info","ts":"2026-05-12T11:23:54.057647Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b5a1dacc8ba86a4f","initial-advertise-peer-urls":["https://199.19.213.203:2380"],"listen-peer-urls":["https://199.19.213.203:2380"],"advertise-client-urls":["https://199.19.213.203:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.203:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-12T11:23:54.057713Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-12T11:23:54.341994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f is starting a new election at term 1"} {"level":"info","ts":"2026-05-12T11:23:54.342084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f became pre-candidate at term 1"} {"level":"info","ts":"2026-05-12T11:23:54.342128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f received MsgPreVoteResp from b5a1dacc8ba86a4f at term 1"} {"level":"info","ts":"2026-05-12T11:23:54.342165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f became candidate at term 2"} {"level":"info","ts":"2026-05-12T11:23:54.342186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f received MsgVoteResp from b5a1dacc8ba86a4f at term 2"} {"level":"info","ts":"2026-05-12T11:23:54.34221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b5a1dacc8ba86a4f became leader at term 2"} {"level":"info","ts":"2026-05-12T11:23:54.342232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b5a1dacc8ba86a4f elected leader b5a1dacc8ba86a4f at term 2"} {"level":"info","ts":"2026-05-12T11:23:54.343741Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b5a1dacc8ba86a4f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.203:2379]}","request-path":"/0/members/b5a1dacc8ba86a4f/attributes","cluster-id":"a3ec0b489c26f222","publish-timeout":"7s"} {"level":"info","ts":"2026-05-12T11:23:54.350758Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:23:54.350772Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:23:54.350826Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-12T11:23:54.351025Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:23:54.351088Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-12T11:23:54.351868Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a3ec0b489c26f222","local-member-id":"b5a1dacc8ba86a4f","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:23:54.352036Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:23:54.352083Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:23:54.353115Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-12T11:23:54.358717Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.203:2379"} {"level":"info","ts":"2026-05-12T11:23:57.290087Z","caller":"traceutil/trace.go:171","msg":"trace[1884169097] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:74; }","duration":"295.674204ms","start":"2026-05-12T11:23:56.994356Z","end":"2026-05-12T11:23:57.29003Z","steps":["trace[1884169097] 'read index received' (duration: 295.338031ms)","trace[1884169097] 'applied index is now lower than readState.Index' (duration: 334.833µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:23:57.290457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.05551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-12T11:23:57.29058Z","caller":"traceutil/trace.go:171","msg":"trace[265623589] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:71; }","duration":"296.286226ms","start":"2026-05-12T11:23:56.994271Z","end":"2026-05-12T11:23:57.290557Z","steps":["trace[265623589] 'agreement among raft nodes before linearized reading' (duration: 296.033429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:57.290525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.75026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-12T11:23:57.290766Z","caller":"traceutil/trace.go:171","msg":"trace[256365267] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:71; }","duration":"191.000497ms","start":"2026-05-12T11:23:57.09972Z","end":"2026-05-12T11:23:57.290721Z","steps":["trace[256365267] 'agreement among raft nodes before linearized reading' (duration: 190.690186ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:57.290232Z","caller":"traceutil/trace.go:171","msg":"trace[989762677] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"297.360279ms","start":"2026-05-12T11:23:56.992785Z","end":"2026-05-12T11:23:57.290146Z","steps":["trace[989762677] 'process raft request' (duration: 297.013515ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:57.664467Z","caller":"traceutil/trace.go:171","msg":"trace[1454975164] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"365.413116ms","start":"2026-05-12T11:23:57.299018Z","end":"2026-05-12T11:23:57.664431Z","steps":["trace[1454975164] 'read index received' (duration: 365.16569ms)","trace[1454975164] 'applied index is now lower than readState.Index' (duration: 246.086µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:23:57.664694Z","caller":"traceutil/trace.go:171","msg":"trace[1230582840] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"367.317066ms","start":"2026-05-12T11:23:57.297205Z","end":"2026-05-12T11:23:57.664522Z","steps":["trace[1230582840] 'process raft request' (duration: 367.050957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:57.664796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.721938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-12T11:23:57.664851Z","caller":"traceutil/trace.go:171","msg":"trace[1108239621] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:72; }","duration":"365.851676ms","start":"2026-05-12T11:23:57.298987Z","end":"2026-05-12T11:23:57.664838Z","steps":["trace[1108239621] 'agreement among raft nodes before linearized reading' (duration: 365.563817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:57.664928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:57.29897Z","time spent":"365.945632ms","remote":"127.0.0.1:37074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:aggregate-to-view\" "} {"level":"warn","ts":"2026-05-12T11:23:57.667966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:57.297187Z","time spent":"367.688752ms","remote":"127.0.0.1:37100","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-05-12T11:24:23.040247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.707787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:24:23.040338Z","caller":"traceutil/trace.go:171","msg":"trace[1373822854] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:465; }","duration":"208.823046ms","start":"2026-05-12T11:24:22.831495Z","end":"2026-05-12T11:24:23.040318Z","steps":["trace[1373822854] 'range keys from in-memory index tree' (duration: 208.627281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:29.888457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.096403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:24:29.888545Z","caller":"traceutil/trace.go:171","msg":"trace[1858608213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"284.264315ms","start":"2026-05-12T11:24:29.604263Z","end":"2026-05-12T11:24:29.888527Z","steps":["trace[1858608213] 'range keys from in-memory index tree' (duration: 283.962714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:29.888582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.880597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rfknq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-12T11:24:29.888666Z","caller":"traceutil/trace.go:171","msg":"trace[438673979] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rfknq; range_end:; response_count:1; response_revision:573; }","duration":"502.026968ms","start":"2026-05-12T11:24:29.386619Z","end":"2026-05-12T11:24:29.888646Z","steps":["trace[438673979] 'range keys from in-memory index tree' (duration: 501.705145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:29.888709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:24:29.386579Z","time spent":"502.121925ms","remote":"127.0.0.1:36946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-rfknq\" "} {"level":"info","ts":"2026-05-12T11:24:29.961319Z","caller":"traceutil/trace.go:171","msg":"trace[2076592906] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"254.742619ms","start":"2026-05-12T11:24:29.706546Z","end":"2026-05-12T11:24:29.961289Z","steps":["trace[2076592906] 'process raft request' (duration: 254.004866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:30.268936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.600394ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:24:30.269049Z","caller":"traceutil/trace.go:171","msg":"trace[617342692] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"365.932953ms","start":"2026-05-12T11:24:29.903094Z","end":"2026-05-12T11:24:30.269027Z","steps":["trace[617342692] 'process raft request' (duration: 95.867006ms)","trace[617342692] 'compare' (duration: 269.474125ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:24:30.269353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:24:29.903068Z","time spent":"366.16489ms","remote":"127.0.0.1:36946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:24:30.581211Z","caller":"traceutil/trace.go:171","msg":"trace[623281191] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"422.347777ms","start":"2026-05-12T11:24:30.158836Z","end":"2026-05-12T11:24:30.581183Z","steps":["trace[623281191] 'read index received' (duration: 400.256137ms)","trace[623281191] 'applied index is now lower than readState.Index' (duration: 22.09054ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:24:30.58128Z","caller":"traceutil/trace.go:171","msg":"trace[942537476] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"559.407183ms","start":"2026-05-12T11:24:30.021854Z","end":"2026-05-12T11:24:30.581261Z","steps":["trace[942537476] 'process raft request' (duration: 537.255338ms)","trace[942537476] 'compare' (duration: 21.846823ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:24:30.581381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:24:30.021835Z","time spent":"559.489808ms","remote":"127.0.0.1:37008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:24:30.58147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.629267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-12T11:24:30.581508Z","caller":"traceutil/trace.go:171","msg":"trace[50299388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:576; }","duration":"422.717223ms","start":"2026-05-12T11:24:30.158784Z","end":"2026-05-12T11:24:30.581501Z","steps":["trace[50299388] 'agreement among raft nodes before linearized reading' (duration: 422.519369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:30.581531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:24:30.158758Z","time spent":"422.768747ms","remote":"127.0.0.1:37020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-12T11:24:30.581629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.676085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-12T11:24:30.581685Z","caller":"traceutil/trace.go:171","msg":"trace[724588757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"201.774572ms","start":"2026-05-12T11:24:30.379895Z","end":"2026-05-12T11:24:30.581669Z","steps":["trace[724588757] 'agreement among raft nodes before linearized reading' (duration: 201.61306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:46.599079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.414068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-c62h4\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-12T11:24:46.599183Z","caller":"traceutil/trace.go:171","msg":"trace[1042816230] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-c62h4; range_end:; response_count:1; response_revision:738; }","duration":"104.567595ms","start":"2026-05-12T11:24:46.494598Z","end":"2026-05-12T11:24:46.599165Z","steps":["trace[1042816230] 'range keys from in-memory index tree' (duration: 104.2709ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:26:13.112729Z","caller":"traceutil/trace.go:171","msg":"trace[1743158609] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"111.771103ms","start":"2026-05-12T11:26:13.000929Z","end":"2026-05-12T11:26:13.1127Z","steps":["trace[1743158609] 'process raft request' (duration: 111.414808ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:26:13.564735Z","caller":"traceutil/trace.go:171","msg":"trace[1749622118] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1912; }","duration":"235.006407ms","start":"2026-05-12T11:26:13.32969Z","end":"2026-05-12T11:26:13.564696Z","steps":["trace[1749622118] 'read index received' (duration: 163.244144ms)","trace[1749622118] 'applied index is now lower than readState.Index' (duration: 71.760633ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:26:13.565018Z","caller":"traceutil/trace.go:171","msg":"trace[1933828754] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"403.551411ms","start":"2026-05-12T11:26:13.161432Z","end":"2026-05-12T11:26:13.564983Z","steps":["trace[1933828754] 'process raft request' (duration: 331.649192ms)","trace[1933828754] 'compare' (duration: 71.450309ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:26:13.56513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.422316ms","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-05-12T11:26:13.565219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:26:13.161411Z","time spent":"403.693737ms","remote":"127.0.0.1:36874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":629,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:26:13.565243Z","caller":"traceutil/trace.go:171","msg":"trace[1708536945] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1854; }","duration":"235.588792ms","start":"2026-05-12T11:26:13.329631Z","end":"2026-05-12T11:26:13.56522Z","steps":["trace[1708536945] 'agreement among raft nodes before linearized reading' (duration: 235.275378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:26:13.565254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.539098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-05-12T11:26:13.565334Z","caller":"traceutil/trace.go:171","msg":"trace[1947840441] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1854; }","duration":"118.697855ms","start":"2026-05-12T11:26:13.446594Z","end":"2026-05-12T11:26:13.565292Z","steps":["trace[1947840441] 'agreement among raft nodes before linearized reading' (duration: 118.464925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:26:56.011358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.333478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-05-12T11:26:56.01145Z","caller":"traceutil/trace.go:171","msg":"trace[980555537] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2195; }","duration":"103.466005ms","start":"2026-05-12T11:26:55.907962Z","end":"2026-05-12T11:26:56.011428Z","steps":["trace[980555537] 'range keys from in-memory index tree' (duration: 103.140928ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:28:11.188344Z","caller":"traceutil/trace.go:171","msg":"trace[2072343489] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"100.692247ms","start":"2026-05-12T11:28:11.087629Z","end":"2026-05-12T11:28:11.188322Z","steps":["trace[2072343489] 'process raft request' (duration: 92.513736ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:35.833747Z","caller":"traceutil/trace.go:171","msg":"trace[847167510] linearizableReadLoop","detail":"{readStateIndex:4589; appliedIndex:4588; }","duration":"105.057857ms","start":"2026-05-12T11:30:35.728671Z","end":"2026-05-12T11:30:35.833729Z","steps":["trace[847167510] 'read index received' (duration: 104.912704ms)","trace[847167510] 'applied index is now lower than readState.Index' (duration: 144.593µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:30:35.834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.309531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7465"} {"level":"info","ts":"2026-05-12T11:30:35.834032Z","caller":"traceutil/trace.go:171","msg":"trace[147021027] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4398; }","duration":"105.417273ms","start":"2026-05-12T11:30:35.728606Z","end":"2026-05-12T11:30:35.834023Z","steps":["trace[147021027] 'agreement among raft nodes before linearized reading' (duration: 105.202399ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:35.834343Z","caller":"traceutil/trace.go:171","msg":"trace[732896783] transaction","detail":"{read_only:false; response_revision:4398; number_of_response:1; }","duration":"111.296001ms","start":"2026-05-12T11:30:35.723038Z","end":"2026-05-12T11:30:35.834334Z","steps":["trace[732896783] 'process raft request' (duration: 110.599237ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:43.631154Z","caller":"traceutil/trace.go:171","msg":"trace[1897197125] transaction","detail":"{read_only:false; response_revision:4590; number_of_response:1; }","duration":"432.45576ms","start":"2026-05-12T11:30:43.198672Z","end":"2026-05-12T11:30:43.631128Z","steps":["trace[1897197125] 'process raft request' (duration: 348.836264ms)","trace[1897197125] 'compare' (duration: 83.514764ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:30:43.631299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:30:43.198645Z","time spent":"432.592294ms","remote":"127.0.0.1:36844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":881,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:30:43.657869Z","caller":"traceutil/trace.go:171","msg":"trace[737384271] linearizableReadLoop","detail":"{readStateIndex:4789; appliedIndex:4787; }","duration":"269.926931ms","start":"2026-05-12T11:30:43.387917Z","end":"2026-05-12T11:30:43.657844Z","steps":["trace[737384271] 'read index received' (duration: 159.716637ms)","trace[737384271] 'applied index is now lower than readState.Index' (duration: 110.208944ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:43.657912Z","caller":"traceutil/trace.go:171","msg":"trace[750760915] transaction","detail":"{read_only:false; response_revision:4591; number_of_response:1; }","duration":"377.564408ms","start":"2026-05-12T11:30:43.280324Z","end":"2026-05-12T11:30:43.657888Z","steps":["trace[750760915] 'process raft request' (duration: 377.387014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:43.658054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:30:43.280303Z","time spent":"377.66977ms","remote":"127.0.0.1:36946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:30:43.658143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.088514ms","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":"info","ts":"2026-05-12T11:30:43.658195Z","caller":"traceutil/trace.go:171","msg":"trace[1810647396] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:4591; }","duration":"270.32322ms","start":"2026-05-12T11:30:43.387858Z","end":"2026-05-12T11:30:43.658181Z","steps":["trace[1810647396] 'agreement among raft nodes before linearized reading' (duration: 270.108615ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:43.777797Z","caller":"traceutil/trace.go:171","msg":"trace[1321696696] transaction","detail":"{read_only:false; response_revision:4592; number_of_response:1; }","duration":"104.204301ms","start":"2026-05-12T11:30:43.673577Z","end":"2026-05-12T11:30:43.777781Z","steps":["trace[1321696696] 'process raft request' (duration: 103.741491ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:55.075388Z","caller":"traceutil/trace.go:171","msg":"trace[604556075] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"206.702928ms","start":"2026-05-12T11:30:54.86866Z","end":"2026-05-12T11:30:55.075363Z","steps":["trace[604556075] 'process raft request' (duration: 206.538594ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:33:54.782715Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3185} {"level":"info","ts":"2026-05-12T11:33:54.882776Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3185,"took":"97.481086ms","hash":240135927,"current-db-size-bytes":56549376,"current-db-size":"56 MB","current-db-size-in-use-bytes":31326208,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-12T11:33:54.882871Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":240135927,"revision":3185,"compact-revision":-1}