{"level":"warn","ts":"2026-04-27T01:23:45.870425Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T01:23:45.870518Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.5: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.5:2380","--initial-cluster=instance=https://199.19.213.5:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.5:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.5: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-04-27T01:23:45.870582Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T01:23:45.870595Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.5:2380"]} {"level":"info","ts":"2026-04-27T01:23:45.870619Z","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-04-27T01:23:45.871243Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"]} {"level":"info","ts":"2026-04-27T01:23:45.871314Z","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.5:2380"],"listen-peer-urls":["https://199.19.213.5:2380"],"advertise-client-urls":["https://199.19.213.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.5: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-04-27T01:23:45.87511Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.592563ms"} {"level":"info","ts":"2026-04-27T01:23:45.882571Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dcb0af7a3afe1d6d","cluster-id":"4564295d4e5c9a3e"} {"level":"info","ts":"2026-04-27T01:23:45.882681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T01:23:45.88272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became follower at term 0"} {"level":"info","ts":"2026-04-27T01:23:45.882747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dcb0af7a3afe1d6d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T01:23:45.882768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became follower at term 1"} {"level":"info","ts":"2026-04-27T01:23:45.882834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=(15902403223755824493)"} {"level":"warn","ts":"2026-04-27T01:23:45.887565Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T01:23:45.890558Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T01:23:45.891729Z","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-04-27T01:23:45.893524Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dcb0af7a3afe1d6d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T01:23:45.895971Z","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-04-27T01:23:45.897154Z","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-04-27T01:23:45.897205Z","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-04-27T01:23:45.897462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=(15902403223755824493)"} {"level":"info","ts":"2026-04-27T01:23:45.896908Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dcb0af7a3afe1d6d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T01:23:45.898444Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4564295d4e5c9a3e","local-member-id":"dcb0af7a3afe1d6d","added-peer-id":"dcb0af7a3afe1d6d","added-peer-peer-urls":["https://199.19.213.5:2380"]} {"level":"info","ts":"2026-04-27T01:23:45.899617Z","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-04-27T01:23:45.899729Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.5:2380"} {"level":"info","ts":"2026-04-27T01:23:45.899752Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.5:2380"} {"level":"info","ts":"2026-04-27T01:23:45.900541Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dcb0af7a3afe1d6d","initial-advertise-peer-urls":["https://199.19.213.5:2380"],"listen-peer-urls":["https://199.19.213.5:2380"],"advertise-client-urls":["https://199.19.213.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T01:23:45.900586Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T01:23:45.983999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T01:23:45.984228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T01:23:45.9843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d received MsgPreVoteResp from dcb0af7a3afe1d6d at term 1"} {"level":"info","ts":"2026-04-27T01:23:45.984359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became candidate at term 2"} {"level":"info","ts":"2026-04-27T01:23:45.984413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d received MsgVoteResp from dcb0af7a3afe1d6d at term 2"} {"level":"info","ts":"2026-04-27T01:23:45.984466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became leader at term 2"} {"level":"info","ts":"2026-04-27T01:23:45.984515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dcb0af7a3afe1d6d elected leader dcb0af7a3afe1d6d at term 2"} {"level":"info","ts":"2026-04-27T01:23:45.985637Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:23:45.986523Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dcb0af7a3afe1d6d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.5:2379]}","request-path":"/0/members/dcb0af7a3afe1d6d/attributes","cluster-id":"4564295d4e5c9a3e","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T01:23:45.986575Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T01:23:45.986987Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4564295d4e5c9a3e","local-member-id":"dcb0af7a3afe1d6d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:23:45.987207Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:23:45.987316Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T01:23:45.987302Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T01:23:45.987463Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T01:23:45.987592Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T01:23:45.990793Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T01:23:45.990836Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.5:2379"} {"level":"warn","ts":"2026-04-27T01:23:49.813659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.119115ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:23:49.81421Z","caller":"traceutil/trace.go:171","msg":"trace[464291211] transaction","detail":"{read_only:false; response_revision:191; number_of_response:1; }","duration":"509.414431ms","start":"2026-04-27T01:23:49.304436Z","end":"2026-04-27T01:23:49.81385Z","steps":["trace[464291211] 'process raft request' (duration: 168.626107ms)","trace[464291211] 'compare' (duration: 339.96293ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:23:49.8146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:23:49.304422Z","time spent":"509.966947ms","remote":"127.0.0.1:41616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":726,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T01:24:22.61075Z","caller":"traceutil/trace.go:171","msg":"trace[1648407807] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"324.961034ms","start":"2026-04-27T01:24:22.285758Z","end":"2026-04-27T01:24:22.610719Z","steps":["trace[1648407807] 'read index received' (duration: 260.826887ms)","trace[1648407807] 'applied index is now lower than readState.Index' (duration: 64.132767ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:24:22.610821Z","caller":"traceutil/trace.go:171","msg":"trace[1612556471] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"340.528805ms","start":"2026-04-27T01:24:22.270254Z","end":"2026-04-27T01:24:22.610783Z","steps":["trace[1612556471] 'process raft request' (duration: 276.46399ms)","trace[1612556471] 'compare' (duration: 63.765755ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:24:22.610977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:22.270202Z","time spent":"340.690069ms","remote":"127.0.0.1:41634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T01:24:22.611129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.358496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-27T01:24:22.611168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.89614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9k7fs\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-04-27T01:24:22.611212Z","caller":"traceutil/trace.go:171","msg":"trace[1852307928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"325.47763ms","start":"2026-04-27T01:24:22.285711Z","end":"2026-04-27T01:24:22.611189Z","steps":["trace[1852307928] 'agreement among raft nodes before linearized reading' (duration: 325.128389ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:24:22.611243Z","caller":"traceutil/trace.go:171","msg":"trace[223491501] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9k7fs; range_end:; response_count:1; response_revision:576; }","duration":"114.000683ms","start":"2026-04-27T01:24:22.497198Z","end":"2026-04-27T01:24:22.611199Z","steps":["trace[223491501] 'agreement among raft nodes before linearized reading' (duration: 113.668523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:22.611269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:22.285684Z","time spent":"325.573372ms","remote":"127.0.0.1:41544","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-04-27T01:24:23.030547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.802489ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:24:23.030662Z","caller":"traceutil/trace.go:171","msg":"trace[1743894533] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"411.184657ms","start":"2026-04-27T01:24:22.619461Z","end":"2026-04-27T01:24:23.030646Z","steps":["trace[1743894533] 'read index received' (duration: 142.08136ms)","trace[1743894533] 'applied index is now lower than readState.Index' (duration: 269.101847ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:24:23.030727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.259889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:24:23.030756Z","caller":"traceutil/trace.go:171","msg":"trace[291297336] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:577; }","duration":"411.306312ms","start":"2026-04-27T01:24:22.619439Z","end":"2026-04-27T01:24:23.030745Z","steps":["trace[291297336] 'agreement among raft nodes before linearized reading' (duration: 411.25196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:23.030792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:22.619425Z","time spent":"411.357803ms","remote":"127.0.0.1:58730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"info","ts":"2026-04-27T01:24:23.030785Z","caller":"traceutil/trace.go:171","msg":"trace[887316443] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"413.053946ms","start":"2026-04-27T01:24:22.61771Z","end":"2026-04-27T01:24:23.030764Z","steps":["trace[887316443] 'process raft request' (duration: 143.813153ms)","trace[887316443] 'compare' (duration: 268.632524ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:24:23.030892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:22.617687Z","time spent":"413.146988ms","remote":"127.0.0.1:41544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:24:23.200793Z","caller":"traceutil/trace.go:171","msg":"trace[1218233600] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"574.083731ms","start":"2026-04-27T01:24:22.626678Z","end":"2026-04-27T01:24:23.200762Z","steps":["trace[1218233600] 'process raft request' (duration: 573.863235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:23.201172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:22.626625Z","time spent":"574.262987ms","remote":"127.0.0.1:41440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:24:23.827016Z","caller":"traceutil/trace.go:171","msg":"trace[612049716] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"343.368206ms","start":"2026-04-27T01:24:23.483614Z","end":"2026-04-27T01:24:23.826982Z","steps":["trace[612049716] 'read index received' (duration: 342.568761ms)","trace[612049716] 'applied index is now lower than readState.Index' (duration: 798.245µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:24:23.827061Z","caller":"traceutil/trace.go:171","msg":"trace[1929305094] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"402.118452ms","start":"2026-04-27T01:24:23.42492Z","end":"2026-04-27T01:24:23.827038Z","steps":["trace[1929305094] 'process raft request' (duration: 401.534734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:23.827139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.523601ms","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-04-27T01:24:23.827171Z","caller":"traceutil/trace.go:171","msg":"trace[1179675342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:579; }","duration":"343.638034ms","start":"2026-04-27T01:24:23.483523Z","end":"2026-04-27T01:24:23.827161Z","steps":["trace[1179675342] 'agreement among raft nodes before linearized reading' (duration: 343.563442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:24:23.827186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:23.424883Z","time spent":"402.232965ms","remote":"127.0.0.1:41368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T01:24:23.827201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:24:23.483492Z","time spent":"343.702066ms","remote":"127.0.0.1:41544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-27T01:24:46.860567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.662469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-m9fhs\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-04-27T01:24:46.860788Z","caller":"traceutil/trace.go:171","msg":"trace[1252990071] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-m9fhs; range_end:; response_count:1; response_revision:763; }","duration":"230.936327ms","start":"2026-04-27T01:24:46.629824Z","end":"2026-04-27T01:24:46.86076Z","steps":["trace[1252990071] 'range keys from in-memory index tree' (duration: 230.418052ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:11.442945Z","caller":"traceutil/trace.go:171","msg":"trace[2060202505] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"197.657902ms","start":"2026-04-27T01:26:11.245249Z","end":"2026-04-27T01:26:11.442907Z","steps":["trace[2060202505] 'read index received' (duration: 195.489883ms)","trace[2060202505] 'applied index is now lower than readState.Index' (duration: 2.166429ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:26:11.44321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.940879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ea4d6abc-ceeb-43b0-a02c-8573afc08e2c\" ","response":"range_response_count:1 size:3745"} {"level":"info","ts":"2026-04-27T01:26:11.443255Z","caller":"traceutil/trace.go:171","msg":"trace[1107818048] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ea4d6abc-ceeb-43b0-a02c-8573afc08e2c; range_end:; response_count:1; response_revision:1859; }","duration":"198.052891ms","start":"2026-04-27T01:26:11.245187Z","end":"2026-04-27T01:26:11.44324Z","steps":["trace[1107818048] 'agreement among raft nodes before linearized reading' (duration: 197.927428ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:11.442958Z","caller":"traceutil/trace.go:171","msg":"trace[583850274] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"325.615232ms","start":"2026-04-27T01:26:11.117303Z","end":"2026-04-27T01:26:11.442918Z","steps":["trace[583850274] 'process raft request' (duration: 323.568096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:26:11.44355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.835555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18aa125751dbc21a\" ","response":"range_response_count:1 size:982"} {"level":"warn","ts":"2026-04-27T01:26:11.443617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.726711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T01:26:11.44371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:26:11.117283Z","time spent":"326.321338ms","remote":"127.0.0.1:41440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3730,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:26:11.443744Z","caller":"traceutil/trace.go:171","msg":"trace[1864378908] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1859; }","duration":"109.906515ms","start":"2026-04-27T01:26:11.33381Z","end":"2026-04-27T01:26:11.443717Z","steps":["trace[1864378908] 'agreement among raft nodes before linearized reading' (duration: 109.702271ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:11.444317Z","caller":"traceutil/trace.go:171","msg":"trace[755699191] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18aa125751dbc21a; range_end:; response_count:1; response_revision:1859; }","duration":"196.958777ms","start":"2026-04-27T01:26:11.24666Z","end":"2026-04-27T01:26:11.443618Z","steps":["trace[755699191] 'agreement among raft nodes before linearized reading' (duration: 196.693651ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:11.638043Z","caller":"traceutil/trace.go:171","msg":"trace[1631948943] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"138.933206ms","start":"2026-04-27T01:26:11.49908Z","end":"2026-04-27T01:26:11.638013Z","steps":["trace[1631948943] 'process raft request' (duration: 138.781763ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:11.63811Z","caller":"traceutil/trace.go:171","msg":"trace[1440311229] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"180.939768ms","start":"2026-04-27T01:26:11.457113Z","end":"2026-04-27T01:26:11.638053Z","steps":["trace[1440311229] 'process raft request' (duration: 180.471778ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:11.91569Z","caller":"traceutil/trace.go:171","msg":"trace[1141628751] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"266.367724ms","start":"2026-04-27T01:26:11.649286Z","end":"2026-04-27T01:26:11.915654Z","steps":["trace[1141628751] 'process raft request' (duration: 236.058414ms)","trace[1141628751] 'compare' (duration: 30.007993ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:26:11.915815Z","caller":"traceutil/trace.go:171","msg":"trace[653163467] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"265.688089ms","start":"2026-04-27T01:26:11.650079Z","end":"2026-04-27T01:26:11.915767Z","steps":["trace[653163467] 'process raft request' (duration: 265.496915ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:11.916298Z","caller":"traceutil/trace.go:171","msg":"trace[942503219] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"264.794078ms","start":"2026-04-27T01:26:11.651467Z","end":"2026-04-27T01:26:11.916261Z","steps":["trace[942503219] 'process raft request' (duration: 264.168024ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:11.916398Z","caller":"traceutil/trace.go:171","msg":"trace[1769504048] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"238.203743ms","start":"2026-04-27T01:26:11.678168Z","end":"2026-04-27T01:26:11.916372Z","steps":["trace[1769504048] 'process raft request' (duration: 238.031469ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:11.916817Z","caller":"traceutil/trace.go:171","msg":"trace[2046105640] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"265.176357ms","start":"2026-04-27T01:26:11.651619Z","end":"2026-04-27T01:26:11.916795Z","steps":["trace[2046105640] 'process raft request' (duration: 264.054552ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:11.916829Z","caller":"traceutil/trace.go:171","msg":"trace[162393503] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"157.729077ms","start":"2026-04-27T01:26:11.75908Z","end":"2026-04-27T01:26:11.916809Z","steps":["trace[162393503] 'process raft request' (duration: 157.173355ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:24.066255Z","caller":"traceutil/trace.go:171","msg":"trace[1920284018] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"103.082525ms","start":"2026-04-27T01:26:23.963141Z","end":"2026-04-27T01:26:24.066224Z","steps":["trace[1920284018] 'process raft request' (duration: 102.902181ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:24.067176Z","caller":"traceutil/trace.go:171","msg":"trace[1777700681] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"102.639766ms","start":"2026-04-27T01:26:23.96451Z","end":"2026-04-27T01:26:24.06715Z","steps":["trace[1777700681] 'process raft request' (duration: 102.372809ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:24.673253Z","caller":"traceutil/trace.go:171","msg":"trace[983637334] linearizableReadLoop","detail":"{readStateIndex:2048; appliedIndex:2047; }","duration":"143.149972ms","start":"2026-04-27T01:26:24.530075Z","end":"2026-04-27T01:26:24.673225Z","steps":["trace[983637334] 'read index received' (duration: 143.05915ms)","trace[983637334] 'applied index is now lower than readState.Index' (duration: 89.522µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:26:24.673399Z","caller":"traceutil/trace.go:171","msg":"trace[384525433] transaction","detail":"{read_only:false; response_revision:1970; number_of_response:1; }","duration":"158.299149ms","start":"2026-04-27T01:26:24.515087Z","end":"2026-04-27T01:26:24.673386Z","steps":["trace[384525433] 'process raft request' (duration: 157.975371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:26:24.673636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.545411ms","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-04-27T01:26:24.673666Z","caller":"traceutil/trace.go:171","msg":"trace[989957474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1970; }","duration":"143.635563ms","start":"2026-04-27T01:26:24.530022Z","end":"2026-04-27T01:26:24.673658Z","steps":["trace[989957474] 'agreement among raft nodes before linearized reading' (duration: 143.49403ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:44.28404Z","caller":"traceutil/trace.go:171","msg":"trace[2001259913] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"112.127252ms","start":"2026-04-27T01:26:44.171885Z","end":"2026-04-27T01:26:44.284012Z","steps":["trace[2001259913] 'process raft request' (duration: 111.949358ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:44.292668Z","caller":"traceutil/trace.go:171","msg":"trace[152583168] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"119.554286ms","start":"2026-04-27T01:26:44.173095Z","end":"2026-04-27T01:26:44.292649Z","steps":["trace[152583168] 'process raft request' (duration: 119.109185ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:44.757683Z","caller":"traceutil/trace.go:171","msg":"trace[1552053009] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"231.502074ms","start":"2026-04-27T01:26:44.526154Z","end":"2026-04-27T01:26:44.757656Z","steps":["trace[1552053009] 'process raft request' (duration: 231.32698ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:45.034049Z","caller":"traceutil/trace.go:171","msg":"trace[775721214] linearizableReadLoop","detail":"{readStateIndex:2181; appliedIndex:2180; }","duration":"225.453596ms","start":"2026-04-27T01:26:44.808565Z","end":"2026-04-27T01:26:45.034019Z","steps":["trace[775721214] 'read index received' (duration: 146.212321ms)","trace[775721214] 'applied index is now lower than readState.Index' (duration: 79.239955ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:26:45.034451Z","caller":"traceutil/trace.go:171","msg":"trace[207807654] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"239.309551ms","start":"2026-04-27T01:26:44.795121Z","end":"2026-04-27T01:26:45.034431Z","steps":["trace[207807654] 'process raft request' (duration: 159.678537ms)","trace[207807654] 'compare' (duration: 79.096221ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:26:45.034829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.252726ms","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-04-27T01:26:45.034913Z","caller":"traceutil/trace.go:171","msg":"trace[819280251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2099; }","duration":"226.391179ms","start":"2026-04-27T01:26:44.808509Z","end":"2026-04-27T01:26:45.0349Z","steps":["trace[819280251] 'agreement among raft nodes before linearized reading' (duration: 226.195034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:26:45.035091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.870875ms","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-04-27T01:26:45.035225Z","caller":"traceutil/trace.go:171","msg":"trace[182510927] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2099; }","duration":"144.06524ms","start":"2026-04-27T01:26:44.891134Z","end":"2026-04-27T01:26:45.035199Z","steps":["trace[182510927] 'agreement among raft nodes before linearized reading' (duration: 143.473045ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:26:45.174936Z","caller":"traceutil/trace.go:171","msg":"trace[490658183] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"133.986853ms","start":"2026-04-27T01:26:45.040911Z","end":"2026-04-27T01:26:45.174898Z","steps":["trace[490658183] 'process raft request' (duration: 127.015579ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:27:55.238372Z","caller":"traceutil/trace.go:171","msg":"trace[1389093868] linearizableReadLoop","detail":"{readStateIndex:2675; appliedIndex:2674; }","duration":"159.267236ms","start":"2026-04-27T01:27:55.079079Z","end":"2026-04-27T01:27:55.238346Z","steps":["trace[1389093868] 'read index received' (duration: 159.04374ms)","trace[1389093868] 'applied index is now lower than readState.Index' (duration: 222.286µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T01:27:55.238411Z","caller":"traceutil/trace.go:171","msg":"trace[1256832948] transaction","detail":"{read_only:false; response_revision:2577; number_of_response:1; }","duration":"171.757508ms","start":"2026-04-27T01:27:55.066623Z","end":"2026-04-27T01:27:55.238381Z","steps":["trace[1256832948] 'process raft request' (duration: 171.526011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:27:55.238527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.43ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T01:27:55.23857Z","caller":"traceutil/trace.go:171","msg":"trace[532119269] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2577; }","duration":"159.556033ms","start":"2026-04-27T01:27:55.078998Z","end":"2026-04-27T01:27:55.238554Z","steps":["trace[532119269] 'agreement among raft nodes before linearized reading' (duration: 159.457421ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:28:26.769144Z","caller":"traceutil/trace.go:171","msg":"trace[240740812] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"107.783456ms","start":"2026-04-27T01:28:26.661307Z","end":"2026-04-27T01:28:26.769091Z","steps":["trace[240740812] 'process raft request' (duration: 107.348904ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:32:25.663023Z","caller":"traceutil/trace.go:171","msg":"trace[318029020] linearizableReadLoop","detail":"{readStateIndex:4883; appliedIndex:4882; }","duration":"190.705818ms","start":"2026-04-27T01:32:25.472296Z","end":"2026-04-27T01:32:25.663002Z","steps":["trace[318029020] 'read index received' (duration: 190.537305ms)","trace[318029020] 'applied index is now lower than readState.Index' (duration: 167.903µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:32:25.663168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.853051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T01:32:25.663194Z","caller":"traceutil/trace.go:171","msg":"trace[1409662045] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4696; }","duration":"190.922973ms","start":"2026-04-27T01:32:25.472264Z","end":"2026-04-27T01:32:25.663187Z","steps":["trace[1409662045] 'agreement among raft nodes before linearized reading' (duration: 190.819641ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T01:32:25.663405Z","caller":"traceutil/trace.go:171","msg":"trace[321223742] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"216.926973ms","start":"2026-04-27T01:32:25.446445Z","end":"2026-04-27T01:32:25.663372Z","steps":["trace[321223742] 'process raft request' (duration: 216.447223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T01:32:44.825284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.884834ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T01:32:44.825394Z","caller":"traceutil/trace.go:171","msg":"trace[663908569] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"377.746735ms","start":"2026-04-27T01:32:44.447629Z","end":"2026-04-27T01:32:44.825376Z","steps":["trace[663908569] 'process raft request' (duration: 102.697227ms)","trace[663908569] 'compare' (duration: 274.454195ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T01:32:44.825457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T01:32:44.447605Z","time spent":"377.821316ms","remote":"127.0.0.1:57936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4709,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T01:33:46.330422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2854} {"level":"info","ts":"2026-04-27T01:33:46.42983Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2854,"took":"96.511855ms","hash":3849696392,"current-db-size-bytes":53891072,"current-db-size":"54 MB","current-db-size-in-use-bytes":28987392,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-27T01:33:46.429887Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3849696392,"revision":2854,"compact-revision":-1} {"level":"info","ts":"2026-04-27T01:38:46.338016Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5526} {"level":"info","ts":"2026-04-27T01:38:46.419755Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5526,"took":"79.714286ms","hash":1539101587,"current-db-size-bytes":53891072,"current-db-size":"54 MB","current-db-size-in-use-bytes":18444288,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-27T01:38:46.419874Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1539101587,"revision":5526,"compact-revision":2854}