{"level":"warn","ts":"2026-09-17T17:59:31.66853Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-17T17:59:31.668656Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.105:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.105:2380","--initial-cluster=instance=https://162.253.55.105:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.105:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.105:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-17T17:59:31.668741Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-17T17:59:31.668759Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.105:2380"]} {"level":"info","ts":"2026-09-17T17:59:31.668785Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-17T17:59:31.669538Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"]} {"level":"info","ts":"2026-09-17T17:59:31.669701Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.105:2380"],"listen-peer-urls":["https://162.253.55.105:2380"],"advertise-client-urls":["https://162.253.55.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.105:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-17T17:59:31.675331Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.271342ms"} {"level":"info","ts":"2026-09-17T17:59:31.683578Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"15a19459cc268924","cluster-id":"9aaad1c0fc15509e"} {"level":"info","ts":"2026-09-17T17:59:31.683665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=()"} {"level":"info","ts":"2026-09-17T17:59:31.683694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became follower at term 0"} {"level":"info","ts":"2026-09-17T17:59:31.683709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 15a19459cc268924 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-17T17:59:31.683723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became follower at term 1"} {"level":"info","ts":"2026-09-17T17:59:31.68377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=(1558690059444980004)"} {"level":"warn","ts":"2026-09-17T17:59:31.693806Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-17T17:59:31.695352Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-17T17:59:31.696808Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-17T17:59:31.698838Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"15a19459cc268924","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-17T17:59:31.702689Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"15a19459cc268924","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-17T17:59:31.702798Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-17T17:59:31.703188Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-17T17:59:31.703213Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-17T17:59:31.703683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=(1558690059444980004)"} {"level":"info","ts":"2026-09-17T17:59:31.704582Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-17T17:59:31.704842Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"15a19459cc268924","initial-advertise-peer-urls":["https://162.253.55.105:2380"],"listen-peer-urls":["https://162.253.55.105:2380"],"advertise-client-urls":["https://162.253.55.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-17T17:59:31.704875Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-17T17:59:31.704959Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.105:2380"} {"level":"info","ts":"2026-09-17T17:59:31.704993Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.105:2380"} {"level":"info","ts":"2026-09-17T17:59:31.705262Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9aaad1c0fc15509e","local-member-id":"15a19459cc268924","added-peer-id":"15a19459cc268924","added-peer-peer-urls":["https://162.253.55.105:2380"]} {"level":"info","ts":"2026-09-17T17:59:32.684224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 is starting a new election at term 1"} {"level":"info","ts":"2026-09-17T17:59:32.684327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-17T17:59:32.684361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 received MsgPreVoteResp from 15a19459cc268924 at term 1"} {"level":"info","ts":"2026-09-17T17:59:32.684383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became candidate at term 2"} {"level":"info","ts":"2026-09-17T17:59:32.684395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 received MsgVoteResp from 15a19459cc268924 at term 2"} {"level":"info","ts":"2026-09-17T17:59:32.684412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became leader at term 2"} {"level":"info","ts":"2026-09-17T17:59:32.684426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 15a19459cc268924 elected leader 15a19459cc268924 at term 2"} {"level":"info","ts":"2026-09-17T17:59:32.685544Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"15a19459cc268924","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.105:2379]}","request-path":"/0/members/15a19459cc268924/attributes","cluster-id":"9aaad1c0fc15509e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-17T17:59:32.68556Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-17T17:59:32.685581Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T17:59:32.685628Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-17T17:59:32.685859Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-17T17:59:32.685946Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-17T17:59:32.686769Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9aaad1c0fc15509e","local-member-id":"15a19459cc268924","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T17:59:32.68698Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T17:59:32.687038Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T17:59:32.69013Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.105:2379"} {"level":"info","ts":"2026-09-17T17:59:32.69028Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-17T17:59:35.947028Z","caller":"traceutil/trace.go:171","msg":"trace[82296868] linearizableReadLoop","detail":"{readStateIndex:123; appliedIndex:122; }","duration":"296.343542ms","start":"2026-09-17T17:59:35.650652Z","end":"2026-09-17T17:59:35.946996Z","steps":["trace[82296868] 'read index received' (duration: 282.719249ms)","trace[82296868] 'applied index is now lower than readState.Index' (duration: 13.623323ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T17:59:35.947348Z","caller":"traceutil/trace.go:171","msg":"trace[530224530] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"297.39434ms","start":"2026-09-17T17:59:35.649942Z","end":"2026-09-17T17:59:35.947336Z","steps":["trace[530224530] 'process raft request' (duration: 283.37435ms)","trace[530224530] 'compare' (duration: 13.528852ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T17:59:35.947667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.978273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-17T17:59:35.947709Z","caller":"traceutil/trace.go:171","msg":"trace[1805682901] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:0; response_revision:118; }","duration":"297.075215ms","start":"2026-09-17T17:59:35.650624Z","end":"2026-09-17T17:59:35.947699Z","steps":["trace[1805682901] 'agreement among raft nodes before linearized reading' (duration: 296.966273ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T17:59:35.947658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.343853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-17T17:59:35.947788Z","caller":"traceutil/trace.go:171","msg":"trace[712299420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:118; }","duration":"258.520846ms","start":"2026-09-17T17:59:35.689233Z","end":"2026-09-17T17:59:35.947754Z","steps":["trace[712299420] 'agreement among raft nodes before linearized reading' (duration: 258.204081ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T17:59:36.249018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.414094ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-17T17:59:36.249127Z","caller":"traceutil/trace.go:171","msg":"trace[362264936] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"292.985966ms","start":"2026-09-17T17:59:35.956123Z","end":"2026-09-17T17:59:36.249109Z","steps":["trace[362264936] 'process raft request' (duration: 155.928721ms)","trace[362264936] 'compare' (duration: 136.277861ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:00:18.917657Z","caller":"traceutil/trace.go:171","msg":"trace[193287395] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"147.186597ms","start":"2026-09-17T18:00:18.770445Z","end":"2026-09-17T18:00:18.917631Z","steps":["trace[193287395] 'process raft request' (duration: 146.552399ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:00:19.354456Z","caller":"traceutil/trace.go:171","msg":"trace[692055771] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"329.678234ms","start":"2026-09-17T18:00:19.024734Z","end":"2026-09-17T18:00:19.354413Z","steps":["trace[692055771] 'read index received' (duration: 329.579393ms)","trace[692055771] 'applied index is now lower than readState.Index' (duration: 97.591µs)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:00:19.354486Z","caller":"traceutil/trace.go:171","msg":"trace[238547233] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"332.195578ms","start":"2026-09-17T18:00:19.022247Z","end":"2026-09-17T18:00:19.354442Z","steps":["trace[238547233] 'process raft request' (duration: 332.038575ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:00:19.354705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.949428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-09-17T18:00:19.354674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T18:00:19.022228Z","time spent":"332.37ms","remote":"127.0.0.1:58502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-17T18:00:19.354757Z","caller":"traceutil/trace.go:171","msg":"trace[117195162] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"330.043559ms","start":"2026-09-17T18:00:19.024702Z","end":"2026-09-17T18:00:19.354746Z","steps":["trace[117195162] 'agreement among raft nodes before linearized reading' (duration: 329.844747ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:00:19.35479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T18:00:19.024687Z","time spent":"330.09495ms","remote":"127.0.0.1:58556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-17T18:00:19.577634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.859101ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T18:00:19.578186Z","caller":"traceutil/trace.go:171","msg":"trace[1462464486] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"189.429088ms","start":"2026-09-17T18:00:19.388737Z","end":"2026-09-17T18:00:19.578166Z","steps":["trace[1462464486] 'process raft request' (duration: 189.250315ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:00:19.5786Z","caller":"traceutil/trace.go:171","msg":"trace[1044532130] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"552.133788ms","start":"2026-09-17T18:00:19.026426Z","end":"2026-09-17T18:00:19.57856Z","steps":["trace[1044532130] 'process raft request' (duration: 403.243127ms)","trace[1044532130] 'compare' (duration: 145.01831ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T18:00:19.578678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T18:00:19.026416Z","time spent":"552.22156ms","remote":"127.0.0.1:58556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T18:00:19.579306Z","caller":"traceutil/trace.go:171","msg":"trace[592570176] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"224.764434ms","start":"2026-09-17T18:00:19.354523Z","end":"2026-09-17T18:00:19.579287Z","steps":["trace[592570176] 'read index received' (duration: 75.160854ms)","trace[592570176] 'applied index is now lower than readState.Index' (duration: 149.60147ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:00:19.579747Z","caller":"traceutil/trace.go:171","msg":"trace[1094355908] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"215.37328ms","start":"2026-09-17T18:00:19.364361Z","end":"2026-09-17T18:00:19.579735Z","steps":["trace[1094355908] 'process raft request' (duration: 213.416835ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:00:19.580026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.252713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-b279m\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-17T18:00:19.580057Z","caller":"traceutil/trace.go:171","msg":"trace[1008655716] range","detail":"{range_begin:/registry/pods/kube-system/cilium-b279m; range_end:; response_count:1; response_revision:634; }","duration":"491.283773ms","start":"2026-09-17T18:00:19.088762Z","end":"2026-09-17T18:00:19.580046Z","steps":["trace[1008655716] 'agreement among raft nodes before linearized reading' (duration: 491.148291ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:00:19.580105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T18:00:19.088742Z","time spent":"491.334494ms","remote":"127.0.0.1:58482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-b279m\" "} {"level":"warn","ts":"2026-09-17T18:00:19.580305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.253245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T18:00:19.580368Z","caller":"traceutil/trace.go:171","msg":"trace[939712159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"501.342246ms","start":"2026-09-17T18:00:19.079009Z","end":"2026-09-17T18:00:19.580352Z","steps":["trace[939712159] 'agreement among raft nodes before linearized reading' (duration: 501.241895ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:00:19.580392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T18:00:19.078994Z","time spent":"501.393996ms","remote":"127.0.0.1:58324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-17T18:00:19.580535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.425274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T18:00:19.580561Z","caller":"traceutil/trace.go:171","msg":"trace[524392991] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:634; }","duration":"213.468455ms","start":"2026-09-17T18:00:19.367083Z","end":"2026-09-17T18:00:19.580552Z","steps":["trace[524392991] 'agreement among raft nodes before linearized reading' (duration: 213.433045ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:00:21.331812Z","caller":"traceutil/trace.go:171","msg":"trace[2068529332] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"112.033749ms","start":"2026-09-17T18:00:21.219738Z","end":"2026-09-17T18:00:21.331771Z","steps":["trace[2068529332] 'process raft request' (duration: 35.045239ms)","trace[2068529332] 'compare' (duration: 76.791748ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:00:36.081834Z","caller":"traceutil/trace.go:171","msg":"trace[1119732104] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"129.705872ms","start":"2026-09-17T18:00:35.952087Z","end":"2026-09-17T18:00:36.081793Z","steps":["trace[1119732104] 'process raft request' (duration: 129.348278ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:00:36.32969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.346354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-n7nr4\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-09-17T18:00:36.329823Z","caller":"traceutil/trace.go:171","msg":"trace[1452348969] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-n7nr4; range_end:; response_count:1; response_revision:809; }","duration":"124.561137ms","start":"2026-09-17T18:00:36.205233Z","end":"2026-09-17T18:00:36.329794Z","steps":["trace[1452348969] 'range keys from in-memory index tree' (duration: 124.171802ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:02:08.21273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.086494ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T18:02:08.21326Z","caller":"traceutil/trace.go:171","msg":"trace[1248694173] linearizableReadLoop","detail":"{readStateIndex:2010; appliedIndex:2009; }","duration":"131.441335ms","start":"2026-09-17T18:02:08.08179Z","end":"2026-09-17T18:02:08.213232Z","steps":["trace[1248694173] 'read index received' (duration: 95.991µs)","trace[1248694173] 'applied index is now lower than readState.Index' (duration: 131.342884ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:02:08.213311Z","caller":"traceutil/trace.go:171","msg":"trace[387710780] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"370.81737ms","start":"2026-09-17T18:02:07.842449Z","end":"2026-09-17T18:02:08.213266Z","steps":["trace[387710780] 'process raft request' (duration: 81.038228ms)","trace[387710780] 'compare' (duration: 288.66815ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T18:02:08.213408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.610586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T18:02:08.213503Z","caller":"traceutil/trace.go:171","msg":"trace[963202072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1941; }","duration":"131.787288ms","start":"2026-09-17T18:02:08.081687Z","end":"2026-09-17T18:02:08.213475Z","steps":["trace[963202072] 'agreement among raft nodes before linearized reading' (duration: 131.619776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:02:08.213602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T18:02:07.842416Z","time spent":"371.046182ms","remote":"127.0.0.1:58556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T18:02:08.642495Z","caller":"traceutil/trace.go:171","msg":"trace[1953869389] linearizableReadLoop","detail":"{readStateIndex:2014; appliedIndex:2014; }","duration":"175.771283ms","start":"2026-09-17T18:02:08.466598Z","end":"2026-09-17T18:02:08.642369Z","steps":["trace[1953869389] 'read index received' (duration: 175.714082ms)","trace[1953869389] 'applied index is now lower than readState.Index' (duration: 52.92µs)"],"step_count":2} {"level":"warn","ts":"2026-09-17T18:02:08.64271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.037795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b7129b52-b932-4110-984a-5f6a3d853012\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-17T18:02:08.642822Z","caller":"traceutil/trace.go:171","msg":"trace[1512160298] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b7129b52-b932-4110-984a-5f6a3d853012; range_end:; response_count:1; response_revision:1945; }","duration":"176.274277ms","start":"2026-09-17T18:02:08.466521Z","end":"2026-09-17T18:02:08.642795Z","steps":["trace[1512160298] 'agreement among raft nodes before linearized reading' (duration: 175.924883ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:02:08.643057Z","caller":"traceutil/trace.go:171","msg":"trace[1224953064] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"244.499275ms","start":"2026-09-17T18:02:08.3979Z","end":"2026-09-17T18:02:08.642399Z","steps":["trace[1224953064] 'process raft request' (duration: 244.132051ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:02:21.28425Z","caller":"traceutil/trace.go:171","msg":"trace[301275190] transaction","detail":"{read_only:false; response_revision:2046; number_of_response:1; }","duration":"129.61265ms","start":"2026-09-17T18:02:21.154535Z","end":"2026-09-17T18:02:21.284147Z","steps":["trace[301275190] 'process raft request' (duration: 129.424508ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:02:42.667503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.061155ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T18:02:42.667699Z","caller":"traceutil/trace.go:171","msg":"trace[2119218245] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"159.651857ms","start":"2026-09-17T18:02:42.50803Z","end":"2026-09-17T18:02:42.667681Z","steps":["trace[2119218245] 'process raft request' (duration: 44.332522ms)","trace[2119218245] 'compare' (duration: 114.971152ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:02:43.007543Z","caller":"traceutil/trace.go:171","msg":"trace[1571125136] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"121.668192ms","start":"2026-09-17T18:02:42.885851Z","end":"2026-09-17T18:02:43.007519Z","steps":["trace[1571125136] 'process raft request' (duration: 107.597443ms)","trace[1571125136] 'compare' (duration: 13.775288ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:02:43.344672Z","caller":"traceutil/trace.go:171","msg":"trace[1846950245] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"152.706253ms","start":"2026-09-17T18:02:43.191907Z","end":"2026-09-17T18:02:43.344613Z","steps":["trace[1846950245] 'process raft request' (duration: 152.407722ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:02:44.609785Z","caller":"traceutil/trace.go:171","msg":"trace[2015870678] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"189.266045ms","start":"2026-09-17T18:02:44.420481Z","end":"2026-09-17T18:02:44.609747Z","steps":["trace[2015870678] 'process raft request' (duration: 189.024786ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:02:44.610216Z","caller":"traceutil/trace.go:171","msg":"trace[348777251] linearizableReadLoop","detail":"{readStateIndex:2267; appliedIndex:2267; }","duration":"151.933083ms","start":"2026-09-17T18:02:44.458232Z","end":"2026-09-17T18:02:44.610165Z","steps":["trace[348777251] 'read index received' (duration: 151.923543ms)","trace[348777251] 'applied index is now lower than readState.Index' (duration: 6.52µs)"],"step_count":2} {"level":"warn","ts":"2026-09-17T18:02:44.610504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.256305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-17T18:02:44.610562Z","caller":"traceutil/trace.go:171","msg":"trace[1356468927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2189; }","duration":"152.352699ms","start":"2026-09-17T18:02:44.458191Z","end":"2026-09-17T18:02:44.610543Z","steps":["trace[1356468927] 'agreement among raft nodes before linearized reading' (duration: 152.160421ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:02:44.610803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.489164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-17T18:02:44.610935Z","caller":"traceutil/trace.go:171","msg":"trace[1856757100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2189; }","duration":"152.708222ms","start":"2026-09-17T18:02:44.45819Z","end":"2026-09-17T18:02:44.610899Z","steps":["trace[1856757100] 'agreement among raft nodes before linearized reading' (duration: 152.233354ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:02:44.763135Z","caller":"traceutil/trace.go:171","msg":"trace[949107576] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"147.884526ms","start":"2026-09-17T18:02:44.61518Z","end":"2026-09-17T18:02:44.763065Z","steps":["trace[949107576] 'process raft request' (duration: 58.344675ms)","trace[949107576] 'compare' (duration: 89.223659ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:02:44.961833Z","caller":"traceutil/trace.go:171","msg":"trace[1995622137] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2267; }","duration":"289.765012ms","start":"2026-09-17T18:02:44.672034Z","end":"2026-09-17T18:02:44.961799Z","steps":["trace[1995622137] 'read index received' (duration: 1.505969ms)","trace[1995622137] 'applied index is now lower than readState.Index' (duration: 288.257603ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:02:44.962002Z","caller":"traceutil/trace.go:171","msg":"trace[1523471092] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"345.581369ms","start":"2026-09-17T18:02:44.616407Z","end":"2026-09-17T18:02:44.961988Z","steps":["trace[1523471092] 'process raft request' (duration: 345.111201ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:02:44.962241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T18:02:44.616375Z","time spent":"345.658573ms","remote":"127.0.0.1:58556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T18:02:44.962582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.9059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-17T18:02:44.962735Z","caller":"traceutil/trace.go:171","msg":"trace[1304991688] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2191; }","duration":"280.15446ms","start":"2026-09-17T18:02:44.682551Z","end":"2026-09-17T18:02:44.962706Z","steps":["trace[1304991688] 'agreement among raft nodes before linearized reading' (duration: 279.736464ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:02:44.962864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.797692ms","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-09-17T18:02:44.962989Z","caller":"traceutil/trace.go:171","msg":"trace[1876331244] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2191; }","duration":"290.993569ms","start":"2026-09-17T18:02:44.671965Z","end":"2026-09-17T18:02:44.962958Z","steps":["trace[1876331244] 'agreement among raft nodes before linearized reading' (duration: 290.383286ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:02:45.199076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.638445ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T18:02:45.199547Z","caller":"traceutil/trace.go:171","msg":"trace[1646134454] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"102.19819ms","start":"2026-09-17T18:02:45.097334Z","end":"2026-09-17T18:02:45.199533Z","steps":["trace[1646134454] 'process raft request' (duration: 101.899658ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:02:45.199634Z","caller":"traceutil/trace.go:171","msg":"trace[1923685717] linearizableReadLoop","detail":"{readStateIndex:2271; appliedIndex:2270; }","duration":"115.70732ms","start":"2026-09-17T18:02:45.083884Z","end":"2026-09-17T18:02:45.199592Z","steps":["trace[1923685717] 'read index received' (duration: 115.724µs)","trace[1923685717] 'applied index is now lower than readState.Index' (duration: 115.589446ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T18:02:45.199829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.930408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T18:02:45.199893Z","caller":"traceutil/trace.go:171","msg":"trace[509501589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2195; }","duration":"116.049333ms","start":"2026-09-17T18:02:45.083827Z","end":"2026-09-17T18:02:45.199876Z","steps":["trace[509501589] 'agreement among raft nodes before linearized reading' (duration: 115.924038ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:02:45.199293Z","caller":"traceutil/trace.go:171","msg":"trace[1366424798] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"184.993074ms","start":"2026-09-17T18:02:45.014249Z","end":"2026-09-17T18:02:45.199242Z","steps":["trace[1366424798] 'process raft request' (duration: 49.071517ms)","trace[1366424798] 'compare' (duration: 135.49535ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:04:55.279463Z","caller":"traceutil/trace.go:171","msg":"trace[98812098] transaction","detail":"{read_only:false; response_revision:2988; number_of_response:1; }","duration":"136.635184ms","start":"2026-09-17T18:04:55.142787Z","end":"2026-09-17T18:04:55.279422Z","steps":["trace[98812098] 'process raft request' (duration: 136.42167ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:05:06.393304Z","caller":"traceutil/trace.go:171","msg":"trace[2114217519] transaction","detail":"{read_only:false; response_revision:3047; number_of_response:1; }","duration":"107.538389ms","start":"2026-09-17T18:05:06.285733Z","end":"2026-09-17T18:05:06.393271Z","steps":["trace[2114217519] 'process raft request' (duration: 89.680809ms)","trace[2114217519] 'compare' (duration: 17.691697ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:09:32.723259Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2862} {"level":"info","ts":"2026-09-17T18:09:32.806193Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2862,"took":"81.640021ms","hash":2519566829,"current-db-size-bytes":42389504,"current-db-size":"42 MB","current-db-size-in-use-bytes":16773120,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-09-17T18:09:32.806301Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2519566829,"revision":2862,"compact-revision":-1} {"level":"info","ts":"2026-09-17T18:09:54.648707Z","caller":"traceutil/trace.go:171","msg":"trace[225363013] transaction","detail":"{read_only:false; response_revision:5259; number_of_response:1; }","duration":"103.785472ms","start":"2026-09-17T18:09:54.5449Z","end":"2026-09-17T18:09:54.648685Z","steps":["trace[225363013] 'process raft request' (duration: 103.289284ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:09:58.334873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.604103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-17T18:09:58.334976Z","caller":"traceutil/trace.go:171","msg":"trace[1050314250] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5337; }","duration":"250.760355ms","start":"2026-09-17T18:09:58.084192Z","end":"2026-09-17T18:09:58.334952Z","steps":["trace[1050314250] 'range keys from in-memory index tree' (duration: 250.39039ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:09:58.335088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.080032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ec2f92f-4926-44f6-8a52-5c0bf3d08ef4\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-17T18:09:58.335185Z","caller":"traceutil/trace.go:171","msg":"trace[446449506] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0ec2f92f-4926-44f6-8a52-5c0bf3d08ef4; range_end:; response_count:1; response_revision:5337; }","duration":"306.271174ms","start":"2026-09-17T18:09:58.02889Z","end":"2026-09-17T18:09:58.335161Z","steps":["trace[446449506] 'range keys from in-memory index tree' (duration: 305.593885ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:09:58.335222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.643095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-17T18:09:58.335228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T18:09:58.028866Z","time spent":"306.351746ms","remote":"127.0.0.1:58482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ec2f92f-4926-44f6-8a52-5c0bf3d08ef4\" "} {"level":"info","ts":"2026-09-17T18:09:58.335252Z","caller":"traceutil/trace.go:171","msg":"trace[1940484555] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5337; }","duration":"253.714727ms","start":"2026-09-17T18:09:58.081528Z","end":"2026-09-17T18:09:58.335243Z","steps":["trace[1940484555] 'range keys from in-memory index tree' (duration: 253.498044ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:00.504877Z","caller":"traceutil/trace.go:171","msg":"trace[1550683550] transaction","detail":"{read_only:false; response_revision:5359; number_of_response:1; }","duration":"146.638631ms","start":"2026-09-17T18:10:00.35819Z","end":"2026-09-17T18:10:00.504828Z","steps":["trace[1550683550] 'process raft request' (duration: 119.029844ms)","trace[1550683550] 'compare' (duration: 27.045469ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:10:13.749657Z","caller":"traceutil/trace.go:171","msg":"trace[526175740] transaction","detail":"{read_only:false; response_revision:5511; number_of_response:1; }","duration":"288.284832ms","start":"2026-09-17T18:10:13.461349Z","end":"2026-09-17T18:10:13.749634Z","steps":["trace[526175740] 'process raft request' (duration: 287.601573ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:13.755447Z","caller":"traceutil/trace.go:171","msg":"trace[982981517] linearizableReadLoop","detail":"{readStateIndex:5718; appliedIndex:5714; }","duration":"283.85133ms","start":"2026-09-17T18:10:13.471566Z","end":"2026-09-17T18:10:13.755417Z","steps":["trace[982981517] 'read index received' (duration: 277.265861ms)","trace[982981517] 'applied index is now lower than readState.Index' (duration: 6.583879ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:10:13.755831Z","caller":"traceutil/trace.go:171","msg":"trace[465652733] transaction","detail":"{read_only:false; response_revision:5515; number_of_response:1; }","duration":"161.669003ms","start":"2026-09-17T18:10:13.594149Z","end":"2026-09-17T18:10:13.755818Z","steps":["trace[465652733] 'process raft request' (duration: 161.180406ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:10:13.756249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.664071ms","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-09-17T18:10:13.756294Z","caller":"traceutil/trace.go:171","msg":"trace[1158849348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5516; }","duration":"284.762493ms","start":"2026-09-17T18:10:13.471522Z","end":"2026-09-17T18:10:13.756284Z","steps":["trace[1158849348] 'agreement among raft nodes before linearized reading' (duration: 284.614911ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:10:13.756486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.596059ms","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-09-17T18:10:13.756524Z","caller":"traceutil/trace.go:171","msg":"trace[389369448] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5516; }","duration":"264.65614ms","start":"2026-09-17T18:10:13.491857Z","end":"2026-09-17T18:10:13.756513Z","steps":["trace[389369448] 'agreement among raft nodes before linearized reading' (duration: 264.559469ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:13.757123Z","caller":"traceutil/trace.go:171","msg":"trace[478672922] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"294.572867ms","start":"2026-09-17T18:10:13.462517Z","end":"2026-09-17T18:10:13.757089Z","steps":["trace[478672922] 'process raft request' (duration: 292.716811ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:13.75717Z","caller":"traceutil/trace.go:171","msg":"trace[1446869398] transaction","detail":"{read_only:false; response_revision:5514; number_of_response:1; }","duration":"294.377054ms","start":"2026-09-17T18:10:13.462759Z","end":"2026-09-17T18:10:13.757136Z","steps":["trace[1446869398] 'process raft request' (duration: 292.520709ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:13.75902Z","caller":"traceutil/trace.go:171","msg":"trace[998632473] transaction","detail":"{read_only:false; response_revision:5512; number_of_response:1; }","duration":"293.887018ms","start":"2026-09-17T18:10:13.462402Z","end":"2026-09-17T18:10:13.756289Z","steps":["trace[998632473] 'process raft request' (duration: 292.672872ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:10:14.298938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.813098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18d62e1b61971959\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-09-17T18:10:14.299068Z","caller":"traceutil/trace.go:171","msg":"trace[2122983790] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18d62e1b61971959; range_end:; response_count:1; response_revision:5521; }","duration":"149.7027ms","start":"2026-09-17T18:10:14.149328Z","end":"2026-09-17T18:10:14.299031Z","steps":["trace[2122983790] 'range keys from in-memory index tree' (duration: 148.591785ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:14.796573Z","caller":"traceutil/trace.go:171","msg":"trace[1762189920] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"486.431947ms","start":"2026-09-17T18:10:14.310107Z","end":"2026-09-17T18:10:14.796539Z","steps":["trace[1762189920] 'process raft request' (duration: 486.192984ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:14.796693Z","caller":"traceutil/trace.go:171","msg":"trace[1369830549] linearizableReadLoop","detail":"{readStateIndex:5727; appliedIndex:5726; }","duration":"318.426498ms","start":"2026-09-17T18:10:14.478222Z","end":"2026-09-17T18:10:14.796649Z","steps":["trace[1369830549] 'read index received' (duration: 318.028523ms)","trace[1369830549] 'applied index is now lower than readState.Index' (duration: 395.005µs)"],"step_count":2} {"level":"warn","ts":"2026-09-17T18:10:14.796771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T18:10:14.310073Z","time spent":"486.58527ms","remote":"127.0.0.1:58482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11655,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T18:10:14.797023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.768513ms","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-09-17T18:10:14.797079Z","caller":"traceutil/trace.go:171","msg":"trace[1407979195] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5523; }","duration":"318.887265ms","start":"2026-09-17T18:10:14.478173Z","end":"2026-09-17T18:10:14.79706Z","steps":["trace[1407979195] 'agreement among raft nodes before linearized reading' (duration: 318.628551ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:10:14.797122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T18:10:14.478149Z","time spent":"318.963256ms","remote":"127.0.0.1:58462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-09-17T18:10:14.867954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.836189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-17T18:10:14.868029Z","caller":"traceutil/trace.go:171","msg":"trace[1761077562] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5524; }","duration":"269.963141ms","start":"2026-09-17T18:10:14.598049Z","end":"2026-09-17T18:10:14.868012Z","steps":["trace[1761077562] 'agreement among raft nodes before linearized reading' (duration: 269.575346ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:14.939725Z","caller":"traceutil/trace.go:171","msg":"trace[986485250] transaction","detail":"{read_only:false; response_revision:5526; number_of_response:1; }","duration":"136.098216ms","start":"2026-09-17T18:10:14.803514Z","end":"2026-09-17T18:10:14.939612Z","steps":["trace[986485250] 'process raft request' (duration: 135.927204ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:14.939937Z","caller":"traceutil/trace.go:171","msg":"trace[1448782763] transaction","detail":"{read_only:false; response_revision:5527; number_of_response:1; }","duration":"128.860638ms","start":"2026-09-17T18:10:14.811032Z","end":"2026-09-17T18:10:14.939892Z","steps":["trace[1448782763] 'process raft request' (duration: 128.497633ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:10:14.94019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.004081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-17T18:10:14.940258Z","caller":"traceutil/trace.go:171","msg":"trace[1813826499] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5527; }","duration":"107.121292ms","start":"2026-09-17T18:10:14.833122Z","end":"2026-09-17T18:10:14.940243Z","steps":["trace[1813826499] 'agreement among raft nodes before linearized reading' (duration: 106.864219ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:14.940336Z","caller":"traceutil/trace.go:171","msg":"trace[388272414] transaction","detail":"{read_only:false; response_revision:5525; number_of_response:1; }","duration":"136.42148ms","start":"2026-09-17T18:10:14.803109Z","end":"2026-09-17T18:10:14.939531Z","steps":["trace[388272414] 'process raft request' (duration: 120.812018ms)","trace[388272414] 'compare' (duration: 15.367329ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T18:10:14.940371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.759505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-0ec2f92f-4926-44f6-8a52-5c0bf3d08ef4\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-09-17T18:10:14.940591Z","caller":"traceutil/trace.go:171","msg":"trace[884444616] range","detail":"{range_begin:/registry/persistentvolumes/pvc-0ec2f92f-4926-44f6-8a52-5c0bf3d08ef4; range_end:; response_count:1; response_revision:5527; }","duration":"137.005608ms","start":"2026-09-17T18:10:14.803567Z","end":"2026-09-17T18:10:14.940573Z","steps":["trace[884444616] 'agreement among raft nodes before linearized reading' (duration: 136.279828ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:10:14.991355Z","caller":"traceutil/trace.go:171","msg":"trace[12697109] transaction","detail":"{read_only:false; response_revision:5528; number_of_response:1; }","duration":"118.227503ms","start":"2026-09-17T18:10:14.873099Z","end":"2026-09-17T18:10:14.991327Z","steps":["trace[12697109] 'process raft request' (duration: 118.02542ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T18:10:15.163163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.049747ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T18:10:15.16345Z","caller":"traceutil/trace.go:171","msg":"trace[135459673] transaction","detail":"{read_only:false; response_revision:5529; number_of_response:1; }","duration":"214.858993ms","start":"2026-09-17T18:10:14.948562Z","end":"2026-09-17T18:10:15.163421Z","steps":["trace[135459673] 'process raft request' (duration: 94.420861ms)","trace[135459673] 'compare' (duration: 119.660841ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:10:15.164103Z","caller":"traceutil/trace.go:171","msg":"trace[1384404851] transaction","detail":"{read_only:false; response_revision:5530; number_of_response:1; }","duration":"207.543493ms","start":"2026-09-17T18:10:14.956545Z","end":"2026-09-17T18:10:15.164089Z","steps":["trace[1384404851] 'process raft request' (duration: 207.381311ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:14:14.3346Z","caller":"traceutil/trace.go:171","msg":"trace[297073875] transaction","detail":"{read_only:false; response_revision:7235; number_of_response:1; }","duration":"107.266177ms","start":"2026-09-17T18:14:14.227287Z","end":"2026-09-17T18:14:14.334553Z","steps":["trace[297073875] 'process raft request' (duration: 106.98081ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:14:32.861454Z","caller":"traceutil/trace.go:171","msg":"trace[1394183478] compact","detail":"{revision:4601; response_revision:7385; }","duration":"112.085864ms","start":"2026-09-17T18:14:32.749345Z","end":"2026-09-17T18:14:32.861431Z","steps":["trace[1394183478] 'process raft request' (duration: 71.346078ms)","trace[1394183478] 'check and update compact revision' (duration: 40.436689ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T18:14:32.86228Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4601} {"level":"info","ts":"2026-09-17T18:14:32.864313Z","caller":"traceutil/trace.go:171","msg":"trace[831480702] transaction","detail":"{read_only:false; response_revision:7386; number_of_response:1; }","duration":"109.313167ms","start":"2026-09-17T18:14:32.754957Z","end":"2026-09-17T18:14:32.86427Z","steps":["trace[831480702] 'process raft request' (duration: 106.331515ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T18:14:32.9601Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4601,"took":"89.120319ms","hash":917226155,"current-db-size-bytes":42389504,"current-db-size":"42 MB","current-db-size-in-use-bytes":33464320,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-17T18:14:32.960195Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":917226155,"revision":4601,"compact-revision":2862} {"level":"info","ts":"2026-09-17T18:19:32.874568Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7385} {"level":"info","ts":"2026-09-17T18:19:32.957413Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7385,"took":"80.93986ms","hash":3246722920,"current-db-size-bytes":42389504,"current-db-size":"42 MB","current-db-size-in-use-bytes":16896000,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-09-17T18:19:32.957482Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3246722920,"revision":7385,"compact-revision":4601}