{"level":"warn","ts":"2026-09-12T06:27:16.310802Z","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-12T06:27:16.311034Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.176: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.176:2380","--initial-cluster=instance=https://162.253.55.176:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.176:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.176: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-12T06:27:16.311138Z","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-12T06:27:16.314808Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-09-12T06:27:16.314858Z","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-12T06:27:16.315626Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"]} {"level":"info","ts":"2026-09-12T06:27:16.315716Z","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.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.176: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-12T06:27:16.324386Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.815525ms"} {"level":"info","ts":"2026-09-12T06:27:16.336747Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"590b810b00f00655","cluster-id":"dcc6923d0deac545"} {"level":"info","ts":"2026-09-12T06:27:16.336926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=()"} {"level":"info","ts":"2026-09-12T06:27:16.336985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 0"} {"level":"info","ts":"2026-09-12T06:27:16.337015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 590b810b00f00655 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-12T06:27:16.337046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 1"} {"level":"info","ts":"2026-09-12T06:27:16.337101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"warn","ts":"2026-09-12T06:27:16.344663Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-12T06:27:16.346842Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-12T06:27:16.351593Z","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-12T06:27:16.354755Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"590b810b00f00655","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-12T06:27:16.35631Z","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-12T06:27:16.356377Z","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-12T06:27:16.356386Z","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-12T06:27:16.358099Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"590b810b00f00655","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-12T06:27:16.35825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"info","ts":"2026-09-12T06:27:16.35851Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","added-peer-id":"590b810b00f00655","added-peer-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-09-12T06:27:16.359732Z","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-12T06:27:16.359987Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"590b810b00f00655","initial-advertise-peer-urls":["https://162.253.55.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-12T06:27:16.36003Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-12T06:27:16.360105Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-09-12T06:27:16.360126Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-09-12T06:27:17.038919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 is starting a new election at term 1"} {"level":"info","ts":"2026-09-12T06:27:17.038999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-12T06:27:17.039035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgPreVoteResp from 590b810b00f00655 at term 1"} {"level":"info","ts":"2026-09-12T06:27:17.039052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became candidate at term 2"} {"level":"info","ts":"2026-09-12T06:27:17.039061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgVoteResp from 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-09-12T06:27:17.039077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became leader at term 2"} {"level":"info","ts":"2026-09-12T06:27:17.039097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 590b810b00f00655 elected leader 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-09-12T06:27:17.040704Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T06:27:17.041576Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"590b810b00f00655","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.176:2379]}","request-path":"/0/members/590b810b00f00655/attributes","cluster-id":"dcc6923d0deac545","publish-timeout":"7s"} {"level":"info","ts":"2026-09-12T06:27:17.041583Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T06:27:17.041606Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T06:27:17.042094Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-12T06:27:17.042156Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-12T06:27:17.043428Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.176:2379"} {"level":"info","ts":"2026-09-12T06:27:17.044881Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-12T06:27:17.058941Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T06:27:17.059212Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T06:27:17.059277Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T06:27:24.118453Z","caller":"traceutil/trace.go:171","msg":"trace[1697240775] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"167.125971ms","start":"2026-09-12T06:27:23.951076Z","end":"2026-09-12T06:27:24.118202Z","steps":["trace[1697240775] 'process raft request' (duration: 166.975991ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:27:24.497844Z","caller":"traceutil/trace.go:171","msg":"trace[100507461] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"516.245716ms","start":"2026-09-12T06:27:23.981554Z","end":"2026-09-12T06:27:24.4978Z","steps":["trace[100507461] 'process raft request' (duration: 516.106105ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:27:24.498453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:27:23.981525Z","time spent":"516.402207ms","remote":"127.0.0.1:44352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":197,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-12T06:27:25.035406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.531479ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-12T06:27:25.035583Z","caller":"traceutil/trace.go:171","msg":"trace[406065627] linearizableReadLoop","detail":"{readStateIndex:298; appliedIndex:297; }","duration":"290.520189ms","start":"2026-09-12T06:27:24.745045Z","end":"2026-09-12T06:27:25.035565Z","steps":["trace[406065627] 'read index received' (duration: 180.553606ms)","trace[406065627] 'applied index is now lower than readState.Index' (duration: 109.965033ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:27:25.035611Z","caller":"traceutil/trace.go:171","msg":"trace[1780427296] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"491.129646ms","start":"2026-09-12T06:27:24.544442Z","end":"2026-09-12T06:27:25.035571Z","steps":["trace[1780427296] 'process raft request' (duration: 381.218514ms)","trace[1780427296] 'compare' (duration: 109.358748ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T06:27:25.035779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.72074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-12T06:27:25.035792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:27:24.544422Z","time spent":"491.283677ms","remote":"127.0.0.1:44352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T06:27:25.035832Z","caller":"traceutil/trace.go:171","msg":"trace[1011442653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:287; }","duration":"290.80878ms","start":"2026-09-12T06:27:24.744996Z","end":"2026-09-12T06:27:25.035804Z","steps":["trace[1011442653] 'agreement among raft nodes before linearized reading' (duration: 290.661179ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:27:25.035929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.76704ms","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-12T06:27:25.036027Z","caller":"traceutil/trace.go:171","msg":"trace[357470022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:287; }","duration":"290.91136ms","start":"2026-09-12T06:27:24.745095Z","end":"2026-09-12T06:27:25.036007Z","steps":["trace[357470022] 'agreement among raft nodes before linearized reading' (duration: 290.674649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:27:57.037884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.893036ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-12T06:27:57.038021Z","caller":"traceutil/trace.go:171","msg":"trace[1408962664] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"162.653838ms","start":"2026-09-12T06:27:56.875346Z","end":"2026-09-12T06:27:57.038Z","steps":["trace[1408962664] 'process raft request' (duration: 61.549715ms)","trace[1408962664] 'compare' (duration: 100.626626ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:27:57.03921Z","caller":"traceutil/trace.go:171","msg":"trace[404911893] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"162.938269ms","start":"2026-09-12T06:27:56.876252Z","end":"2026-09-12T06:27:57.039191Z","steps":["trace[404911893] 'process raft request' (duration: 162.844652ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:28:05.20455Z","caller":"traceutil/trace.go:171","msg":"trace[1763501978] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"131.175365ms","start":"2026-09-12T06:28:05.073344Z","end":"2026-09-12T06:28:05.204519Z","steps":["trace[1763501978] 'process raft request' (duration: 130.356857ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:28:05.532937Z","caller":"traceutil/trace.go:171","msg":"trace[1153017646] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"304.47646ms","start":"2026-09-12T06:28:05.228433Z","end":"2026-09-12T06:28:05.532909Z","steps":["trace[1153017646] 'process raft request' (duration: 304.304158ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:28:05.533311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:28:05.228384Z","time spent":"304.636852ms","remote":"127.0.0.1:44336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T06:28:05.533068Z","caller":"traceutil/trace.go:171","msg":"trace[2144389824] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:623; }","duration":"283.519921ms","start":"2026-09-12T06:28:05.249509Z","end":"2026-09-12T06:28:05.533028Z","steps":["trace[2144389824] 'read index received' (duration: 283.508761ms)","trace[2144389824] 'applied index is now lower than readState.Index' (duration: 8.83µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T06:28:05.533485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.950673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-12T06:28:05.533542Z","caller":"traceutil/trace.go:171","msg":"trace[57837545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:602; }","duration":"284.0511ms","start":"2026-09-12T06:28:05.249474Z","end":"2026-09-12T06:28:05.533525Z","steps":["trace[57837545] 'agreement among raft nodes before linearized reading' (duration: 283.810513ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:28:05.553978Z","caller":"traceutil/trace.go:171","msg":"trace[1252030852] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"277.010326ms","start":"2026-09-12T06:28:05.276904Z","end":"2026-09-12T06:28:05.553915Z","steps":["trace[1252030852] 'process raft request' (duration: 276.606218ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:28:06.152685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.058808ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-12T06:28:06.153276Z","caller":"traceutil/trace.go:171","msg":"trace[518824888] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"619.815571ms","start":"2026-09-12T06:28:05.53342Z","end":"2026-09-12T06:28:06.153235Z","steps":["trace[518824888] 'read index received' (duration: 20.354566ms)","trace[518824888] 'applied index is now lower than readState.Index' (duration: 599.458525ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:28:06.15371Z","caller":"traceutil/trace.go:171","msg":"trace[1590376793] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"614.407992ms","start":"2026-09-12T06:28:05.538888Z","end":"2026-09-12T06:28:06.153296Z","steps":["trace[1590376793] 'process raft request' (duration: 613.901067ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:28:06.154045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:28:05.538866Z","time spent":"614.933539ms","remote":"127.0.0.1:44410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T06:28:06.164265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.295813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T06:28:06.164329Z","caller":"traceutil/trace.go:171","msg":"trace[1132498849] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:604; }","duration":"597.428392ms","start":"2026-09-12T06:28:05.566881Z","end":"2026-09-12T06:28:06.16431Z","steps":["trace[1132498849] 'agreement among raft nodes before linearized reading' (duration: 586.563441ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:28:06.164393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:28:05.56686Z","time spent":"597.520948ms","remote":"127.0.0.1:44376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-09-12T06:28:06.164411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.096661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-12T06:28:06.164459Z","caller":"traceutil/trace.go:171","msg":"trace[785327451] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"845.158075ms","start":"2026-09-12T06:28:05.319285Z","end":"2026-09-12T06:28:06.164443Z","steps":["trace[785327451] 'agreement among raft nodes before linearized reading' (duration: 833.965231ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:28:06.164496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:28:05.319278Z","time spent":"845.207719ms","remote":"127.0.0.1:44410","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-09-12T06:28:06.164492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.541893ms","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-12T06:28:06.164563Z","caller":"traceutil/trace.go:171","msg":"trace[1110261882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"859.641831ms","start":"2026-09-12T06:28:05.30489Z","end":"2026-09-12T06:28:06.164532Z","steps":["trace[1110261882] 'agreement among raft nodes before linearized reading' (duration: 848.530712ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:28:06.164594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:28:05.304866Z","time spent":"859.720277ms","remote":"127.0.0.1:44410","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":"info","ts":"2026-09-12T06:28:23.880848Z","caller":"traceutil/trace.go:171","msg":"trace[641721811] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"227.531968ms","start":"2026-09-12T06:28:23.653297Z","end":"2026-09-12T06:28:23.880829Z","steps":["trace[641721811] 'process raft request' (duration: 227.414292ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:28:53.390399Z","caller":"traceutil/trace.go:171","msg":"trace[875457718] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"159.282711ms","start":"2026-09-12T06:28:53.231087Z","end":"2026-09-12T06:28:53.39037Z","steps":["trace[875457718] 'process raft request' (duration: 159.086424ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:29:16.672055Z","caller":"traceutil/trace.go:171","msg":"trace[22312743] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"106.972491ms","start":"2026-09-12T06:29:16.565052Z","end":"2026-09-12T06:29:16.672024Z","steps":["trace[22312743] 'process raft request' (duration: 106.818167ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:29:16.683593Z","caller":"traceutil/trace.go:171","msg":"trace[1247642624] linearizableReadLoop","detail":"{readStateIndex:1479; appliedIndex:1477; }","duration":"104.663738ms","start":"2026-09-12T06:29:16.578911Z","end":"2026-09-12T06:29:16.683575Z","steps":["trace[1247642624] 'read index received' (duration: 92.948493ms)","trace[1247642624] 'applied index is now lower than readState.Index' (duration: 11.714345ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:29:16.683714Z","caller":"traceutil/trace.go:171","msg":"trace[2067429105] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"116.082823ms","start":"2026-09-12T06:29:16.567601Z","end":"2026-09-12T06:29:16.683684Z","steps":["trace[2067429105] 'process raft request' (duration: 115.688701ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:29:16.683802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.867514ms","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-12T06:29:16.683846Z","caller":"traceutil/trace.go:171","msg":"trace[379278997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1435; }","duration":"104.951387ms","start":"2026-09-12T06:29:16.57888Z","end":"2026-09-12T06:29:16.683831Z","steps":["trace[379278997] 'agreement among raft nodes before linearized reading' (duration: 104.803202ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:29:16.816362Z","caller":"traceutil/trace.go:171","msg":"trace[927702527] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"128.137759ms","start":"2026-09-12T06:29:16.688193Z","end":"2026-09-12T06:29:16.816331Z","steps":["trace[927702527] 'process raft request' (duration: 127.761436ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:29:41.711035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.739339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f5cfc008-e0c8-464f-bae9-5dca002956b9\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-12T06:29:41.711098Z","caller":"traceutil/trace.go:171","msg":"trace[134415577] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f5cfc008-e0c8-464f-bae9-5dca002956b9; range_end:; response_count:1; response_revision:1843; }","duration":"109.851982ms","start":"2026-09-12T06:29:41.601232Z","end":"2026-09-12T06:29:41.711084Z","steps":["trace[134415577] 'range keys from in-memory index tree' (duration: 109.583705ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:29:42.108096Z","caller":"traceutil/trace.go:171","msg":"trace[388174579] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"387.074327ms","start":"2026-09-12T06:29:41.720998Z","end":"2026-09-12T06:29:42.108072Z","steps":["trace[388174579] 'process raft request' (duration: 386.938644ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:29:42.108268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:29:41.720966Z","time spent":"387.19786ms","remote":"127.0.0.1:44336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T06:29:42.160079Z","caller":"traceutil/trace.go:171","msg":"trace[2097459986] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"264.937928ms","start":"2026-09-12T06:29:41.895114Z","end":"2026-09-12T06:29:42.160052Z","steps":["trace[2097459986] 'process raft request' (duration: 223.978012ms)","trace[2097459986] 'compare' (duration: 40.76763ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:29:42.16027Z","caller":"traceutil/trace.go:171","msg":"trace[498911113] linearizableReadLoop","detail":"{readStateIndex:1917; appliedIndex:1915; }","duration":"225.299598ms","start":"2026-09-12T06:29:41.934941Z","end":"2026-09-12T06:29:42.16024Z","steps":["trace[498911113] 'read index received' (duration: 173.123693ms)","trace[498911113] 'applied index is now lower than readState.Index' (duration: 52.152514ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:29:42.160337Z","caller":"traceutil/trace.go:171","msg":"trace[1285279504] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"230.784981ms","start":"2026-09-12T06:29:41.929495Z","end":"2026-09-12T06:29:42.16028Z","steps":["trace[1285279504] 'process raft request' (duration: 230.519133ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:29:42.160648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.668048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-12T06:29:42.160748Z","caller":"traceutil/trace.go:171","msg":"trace[706999793] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1846; }","duration":"225.844752ms","start":"2026-09-12T06:29:41.934884Z","end":"2026-09-12T06:29:42.160728Z","steps":["trace[706999793] 'agreement among raft nodes before linearized reading' (duration: 225.445472ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:29:42.482195Z","caller":"traceutil/trace.go:171","msg":"trace[770637631] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"247.508037ms","start":"2026-09-12T06:29:42.234653Z","end":"2026-09-12T06:29:42.482161Z","steps":["trace[770637631] 'process raft request' (duration: 247.172267ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:29:42.482259Z","caller":"traceutil/trace.go:171","msg":"trace[1213013453] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"247.436055ms","start":"2026-09-12T06:29:42.234789Z","end":"2026-09-12T06:29:42.482225Z","steps":["trace[1213013453] 'process raft request' (duration: 247.314092ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:29:42.482799Z","caller":"traceutil/trace.go:171","msg":"trace[935923652] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"247.721912ms","start":"2026-09-12T06:29:42.235057Z","end":"2026-09-12T06:29:42.482779Z","steps":["trace[935923652] 'process raft request' (duration: 247.124567ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:29:42.4896Z","caller":"traceutil/trace.go:171","msg":"trace[1137619482] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1919; }","duration":"150.303302ms","start":"2026-09-12T06:29:42.339264Z","end":"2026-09-12T06:29:42.489568Z","steps":["trace[1137619482] 'read index received' (duration: 142.594063ms)","trace[1137619482] 'applied index is now lower than readState.Index' (duration: 7.707869ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:29:42.489758Z","caller":"traceutil/trace.go:171","msg":"trace[1549953253] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"221.898377ms","start":"2026-09-12T06:29:42.267741Z","end":"2026-09-12T06:29:42.489639Z","steps":["trace[1549953253] 'process raft request' (duration: 221.651591ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:29:42.490022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.730413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-12T06:29:42.490115Z","caller":"traceutil/trace.go:171","msg":"trace[2006090115] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1852; }","duration":"150.871328ms","start":"2026-09-12T06:29:42.339222Z","end":"2026-09-12T06:29:42.490093Z","steps":["trace[2006090115] 'agreement among raft nodes before linearized reading' (duration: 150.486698ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:29:54.365179Z","caller":"traceutil/trace.go:171","msg":"trace[1049879122] linearizableReadLoop","detail":"{readStateIndex:2026; appliedIndex:2025; }","duration":"118.337358ms","start":"2026-09-12T06:29:54.246816Z","end":"2026-09-12T06:29:54.365153Z","steps":["trace[1049879122] 'read index received' (duration: 118.200204ms)","trace[1049879122] 'applied index is now lower than readState.Index' (duration: 136.154µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:29:54.365257Z","caller":"traceutil/trace.go:171","msg":"trace[1389765895] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"165.434792ms","start":"2026-09-12T06:29:54.199798Z","end":"2026-09-12T06:29:54.365233Z","steps":["trace[1389765895] 'process raft request' (duration: 165.164105ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:29:54.365435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.605205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-12T06:29:54.36698Z","caller":"traceutil/trace.go:171","msg":"trace[60013055] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1952; }","duration":"120.206233ms","start":"2026-09-12T06:29:54.246754Z","end":"2026-09-12T06:29:54.36696Z","steps":["trace[60013055] 'agreement among raft nodes before linearized reading' (duration: 118.521023ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:30:30.890449Z","caller":"traceutil/trace.go:171","msg":"trace[967434875] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"151.778891ms","start":"2026-09-12T06:30:30.738645Z","end":"2026-09-12T06:30:30.890424Z","steps":["trace[967434875] 'process raft request' (duration: 151.637448ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:30:31.207043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.007989ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T06:30:31.207199Z","caller":"traceutil/trace.go:171","msg":"trace[1442726316] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2246; }","duration":"172.416102ms","start":"2026-09-12T06:30:31.034759Z","end":"2026-09-12T06:30:31.207176Z","steps":["trace[1442726316] 'read index received' (duration: 15.137539ms)","trace[1442726316] 'applied index is now lower than readState.Index' (duration: 157.276733ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:30:31.207374Z","caller":"traceutil/trace.go:171","msg":"trace[296770498] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"241.616252ms","start":"2026-09-12T06:30:30.965742Z","end":"2026-09-12T06:30:31.207358Z","steps":["trace[296770498] 'process raft request' (duration: 84.167575ms)","trace[296770498] 'compare' (duration: 156.806044ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T06:30:31.20758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.655073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-12T06:30:31.207699Z","caller":"traceutil/trace.go:171","msg":"trace[203456473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2164; }","duration":"165.830366ms","start":"2026-09-12T06:30:31.041845Z","end":"2026-09-12T06:30:31.207675Z","steps":["trace[203456473] 'agreement among raft nodes before linearized reading' (duration: 165.55217ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:30:31.207818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.994095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-12T06:30:31.207853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.028582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-12T06:30:31.207879Z","caller":"traceutil/trace.go:171","msg":"trace[240675793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2164; }","duration":"163.080953ms","start":"2026-09-12T06:30:31.044786Z","end":"2026-09-12T06:30:31.207867Z","steps":["trace[240675793] 'agreement among raft nodes before linearized reading' (duration: 163.021912ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:30:31.207883Z","caller":"traceutil/trace.go:171","msg":"trace[664287783] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:2164; }","duration":"112.116307ms","start":"2026-09-12T06:30:31.095744Z","end":"2026-09-12T06:30:31.20786Z","steps":["trace[664287783] 'agreement among raft nodes before linearized reading' (duration: 111.987525ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:30:31.208175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.38687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-12T06:30:31.208297Z","caller":"traceutil/trace.go:171","msg":"trace[1476461912] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2164; }","duration":"173.543675ms","start":"2026-09-12T06:30:31.034728Z","end":"2026-09-12T06:30:31.208272Z","steps":["trace[1476461912] 'agreement among raft nodes before linearized reading' (duration: 173.221908ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:30:31.46906Z","caller":"traceutil/trace.go:171","msg":"trace[842883148] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"255.734459ms","start":"2026-09-12T06:30:31.213295Z","end":"2026-09-12T06:30:31.469029Z","steps":["trace[842883148] 'process raft request' (duration: 255.527875ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:30:31.470345Z","caller":"traceutil/trace.go:171","msg":"trace[747464452] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"255.859551ms","start":"2026-09-12T06:30:31.214452Z","end":"2026-09-12T06:30:31.470311Z","steps":["trace[747464452] 'process raft request' (duration: 255.76167ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:30:31.470513Z","caller":"traceutil/trace.go:171","msg":"trace[1511088656] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"256.109906ms","start":"2026-09-12T06:30:31.21439Z","end":"2026-09-12T06:30:31.4705Z","steps":["trace[1511088656] 'process raft request' (duration: 255.702218ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:30:31.47058Z","caller":"traceutil/trace.go:171","msg":"trace[644583395] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"255.367272ms","start":"2026-09-12T06:30:31.215197Z","end":"2026-09-12T06:30:31.470564Z","steps":["trace[644583395] 'process raft request' (duration: 255.067226ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:30:31.470883Z","caller":"traceutil/trace.go:171","msg":"trace[68258639] linearizableReadLoop","detail":"{readStateIndex:2251; appliedIndex:2247; }","duration":"221.994412ms","start":"2026-09-12T06:30:31.248873Z","end":"2026-09-12T06:30:31.470867Z","steps":["trace[68258639] 'read index received' (duration: 220.030564ms)","trace[68258639] 'applied index is now lower than readState.Index' (duration: 1.962768ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T06:30:31.471015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.125594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T06:30:31.471068Z","caller":"traceutil/trace.go:171","msg":"trace[1931079795] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2169; }","duration":"222.239417ms","start":"2026-09-12T06:30:31.248811Z","end":"2026-09-12T06:30:31.47105Z","steps":["trace[1931079795] 'agreement among raft nodes before linearized reading' (duration: 222.116745ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:31:44.403924Z","caller":"traceutil/trace.go:171","msg":"trace[1924804017] linearizableReadLoop","detail":"{readStateIndex:2771; appliedIndex:2770; }","duration":"203.325275ms","start":"2026-09-12T06:31:44.20057Z","end":"2026-09-12T06:31:44.403895Z","steps":["trace[1924804017] 'read index received' (duration: 203.03832ms)","trace[1924804017] 'applied index is now lower than readState.Index' (duration: 285.575µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:31:44.404108Z","caller":"traceutil/trace.go:171","msg":"trace[594747860] transaction","detail":"{read_only:false; response_revision:2672; number_of_response:1; }","duration":"203.819712ms","start":"2026-09-12T06:31:44.200261Z","end":"2026-09-12T06:31:44.404081Z","steps":["trace[594747860] 'process raft request' (duration: 203.443277ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:31:44.404261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.640719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T06:31:44.404319Z","caller":"traceutil/trace.go:171","msg":"trace[2036746748] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2672; }","duration":"203.797713ms","start":"2026-09-12T06:31:44.200505Z","end":"2026-09-12T06:31:44.404303Z","steps":["trace[2036746748] 'agreement among raft nodes before linearized reading' (duration: 203.633739ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:36:09.592124Z","caller":"traceutil/trace.go:171","msg":"trace[702999042] linearizableReadLoop","detail":"{readStateIndex:4785; appliedIndex:4784; }","duration":"117.859913ms","start":"2026-09-12T06:36:09.474241Z","end":"2026-09-12T06:36:09.592101Z","steps":["trace[702999042] 'read index received' (duration: 117.674419ms)","trace[702999042] 'applied index is now lower than readState.Index' (duration: 184.714µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:36:09.5922Z","caller":"traceutil/trace.go:171","msg":"trace[149070248] transaction","detail":"{read_only:false; response_revision:4609; number_of_response:1; }","duration":"118.017736ms","start":"2026-09-12T06:36:09.474146Z","end":"2026-09-12T06:36:09.592164Z","steps":["trace[149070248] 'process raft request' (duration: 117.822783ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:36:09.592388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.130578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-12T06:36:09.59243Z","caller":"traceutil/trace.go:171","msg":"trace[1659900701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4609; }","duration":"118.23574ms","start":"2026-09-12T06:36:09.474184Z","end":"2026-09-12T06:36:09.59242Z","steps":["trace[1659900701] 'agreement among raft nodes before linearized reading' (duration: 118.095737ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:36:09.59254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.394717ms","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-12T06:36:09.592582Z","caller":"traceutil/trace.go:171","msg":"trace[44181514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4609; }","duration":"102.487009ms","start":"2026-09-12T06:36:09.490085Z","end":"2026-09-12T06:36:09.592572Z","steps":["trace[44181514] 'agreement among raft nodes before linearized reading' (duration: 102.320706ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:36:13.439847Z","caller":"traceutil/trace.go:171","msg":"trace[511444350] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"173.949094ms","start":"2026-09-12T06:36:13.265875Z","end":"2026-09-12T06:36:13.439824Z","steps":["trace[511444350] 'process raft request' (duration: 173.699969ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:36:15.790761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.491646ms","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-12T06:36:15.790863Z","caller":"traceutil/trace.go:171","msg":"trace[731790052] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4770; }","duration":"172.63972ms","start":"2026-09-12T06:36:15.6182Z","end":"2026-09-12T06:36:15.79084Z","steps":["trace[731790052] 'range keys from in-memory index tree' (duration: 172.274753ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:36:15.790852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.517757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-12T06:36:15.790902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.750345ms","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-12T06:36:15.791018Z","caller":"traceutil/trace.go:171","msg":"trace[336107996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4770; }","duration":"162.900828ms","start":"2026-09-12T06:36:15.628091Z","end":"2026-09-12T06:36:15.790992Z","steps":["trace[336107996] 'range keys from in-memory index tree' (duration: 162.587352ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:36:15.790942Z","caller":"traceutil/trace.go:171","msg":"trace[618405572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4770; }","duration":"144.66152ms","start":"2026-09-12T06:36:15.646261Z","end":"2026-09-12T06:36:15.790923Z","steps":["trace[618405572] 'range keys from in-memory index tree' (duration: 144.287162ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:36:21.00172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.309339ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T06:36:21.001832Z","caller":"traceutil/trace.go:171","msg":"trace[1476227413] linearizableReadLoop","detail":"{readStateIndex:5092; appliedIndex:5091; }","duration":"194.398212ms","start":"2026-09-12T06:36:20.807415Z","end":"2026-09-12T06:36:21.001813Z","steps":["trace[1476227413] 'read index received' (duration: 19.770396ms)","trace[1476227413] 'applied index is now lower than readState.Index' (duration: 174.626446ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:36:21.00184Z","caller":"traceutil/trace.go:171","msg":"trace[650771274] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"222.412518ms","start":"2026-09-12T06:36:20.779403Z","end":"2026-09-12T06:36:21.001816Z","steps":["trace[650771274] 'process raft request' (duration: 47.895445ms)","trace[650771274] 'compare' (duration: 174.087605ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T06:36:21.002031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.616936ms","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-12T06:36:21.002075Z","caller":"traceutil/trace.go:171","msg":"trace[139593441] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4908; }","duration":"194.719058ms","start":"2026-09-12T06:36:20.807343Z","end":"2026-09-12T06:36:21.002062Z","steps":["trace[139593441] 'agreement among raft nodes before linearized reading' (duration: 194.562405ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:36:34.323849Z","caller":"traceutil/trace.go:171","msg":"trace[2104784476] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"350.007551ms","start":"2026-09-12T06:36:33.973811Z","end":"2026-09-12T06:36:34.323819Z","steps":["trace[2104784476] 'process raft request' (duration: 280.990728ms)","trace[2104784476] 'compare' (duration: 68.509023ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T06:36:34.323993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:36:33.973792Z","time spent":"350.130354ms","remote":"127.0.0.1:44410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T06:36:34.324489Z","caller":"traceutil/trace.go:171","msg":"trace[1477336661] linearizableReadLoop","detail":"{readStateIndex:5265; appliedIndex:5263; }","duration":"279.820414ms","start":"2026-09-12T06:36:34.044646Z","end":"2026-09-12T06:36:34.324466Z","steps":["trace[1477336661] 'read index received' (duration: 210.097728ms)","trace[1477336661] 'applied index is now lower than readState.Index' (duration: 69.720946ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:36:34.324593Z","caller":"traceutil/trace.go:171","msg":"trace[170873890] transaction","detail":"{read_only:false; response_revision:5077; number_of_response:1; }","duration":"350.605583ms","start":"2026-09-12T06:36:33.973976Z","end":"2026-09-12T06:36:34.324582Z","steps":["trace[170873890] 'process raft request' (duration: 349.740496ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:36:34.324792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T06:36:33.973964Z","time spent":"350.674234ms","remote":"127.0.0.1:44410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T06:36:34.324807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.141453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T06:36:34.324881Z","caller":"traceutil/trace.go:171","msg":"trace[1407145334] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:5077; }","duration":"170.298485ms","start":"2026-09-12T06:36:34.154567Z","end":"2026-09-12T06:36:34.324866Z","steps":["trace[1407145334] 'agreement among raft nodes before linearized reading' (duration: 170.152202ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:36:34.324813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.6112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-12T06:36:34.325034Z","caller":"traceutil/trace.go:171","msg":"trace[795844160] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5077; }","duration":"268.870505ms","start":"2026-09-12T06:36:34.056147Z","end":"2026-09-12T06:36:34.325018Z","steps":["trace[795844160] 'agreement among raft nodes before linearized reading' (duration: 268.560739ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:36:34.324721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.10693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T06:36:34.32513Z","caller":"traceutil/trace.go:171","msg":"trace[1008626555] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5077; }","duration":"280.551889ms","start":"2026-09-12T06:36:34.044567Z","end":"2026-09-12T06:36:34.325119Z","steps":["trace[1008626555] 'agreement among raft nodes before linearized reading' (duration: 280.120981ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T06:36:34.325487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.399733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T06:36:34.325622Z","caller":"traceutil/trace.go:171","msg":"trace[624097245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5077; }","duration":"211.580146ms","start":"2026-09-12T06:36:34.11399Z","end":"2026-09-12T06:36:34.32557Z","steps":["trace[624097245] 'agreement among raft nodes before linearized reading' (duration: 210.826392ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:36:34.701777Z","caller":"traceutil/trace.go:171","msg":"trace[45762744] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"114.428544ms","start":"2026-09-12T06:36:34.58706Z","end":"2026-09-12T06:36:34.701488Z","steps":["trace[45762744] 'process raft request' (duration: 114.274361ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:36:35.174712Z","caller":"traceutil/trace.go:171","msg":"trace[586689] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"122.958155ms","start":"2026-09-12T06:36:35.051727Z","end":"2026-09-12T06:36:35.174685Z","steps":["trace[586689] 'process raft request' (duration: 122.898744ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:36:35.174767Z","caller":"traceutil/trace.go:171","msg":"trace[402626805] linearizableReadLoop","detail":"{readStateIndex:5277; appliedIndex:5276; }","duration":"168.983066ms","start":"2026-09-12T06:36:35.005754Z","end":"2026-09-12T06:36:35.174737Z","steps":["trace[402626805] 'read index received' (duration: 79.211287ms)","trace[402626805] 'applied index is now lower than readState.Index' (duration: 89.768779ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T06:36:35.1753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.519566ms","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-12T06:36:35.175429Z","caller":"traceutil/trace.go:171","msg":"trace[663170286] transaction","detail":"{read_only:false; response_revision:5089; number_of_response:1; }","duration":"171.865231ms","start":"2026-09-12T06:36:35.002949Z","end":"2026-09-12T06:36:35.174814Z","steps":["trace[663170286] 'process raft request' (duration: 81.904789ms)","trace[663170286] 'compare' (duration: 89.561774ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T06:36:35.175453Z","caller":"traceutil/trace.go:171","msg":"trace[1463572244] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5090; }","duration":"169.693029ms","start":"2026-09-12T06:36:35.005731Z","end":"2026-09-12T06:36:35.175424Z","steps":["trace[1463572244] 'agreement among raft nodes before linearized reading' (duration: 169.125559ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T06:37:17.085518Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2844} {"level":"info","ts":"2026-09-12T06:37:17.159214Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2844,"took":"72.660454ms","hash":3718197962,"current-db-size-bytes":53198848,"current-db-size":"53 MB","current-db-size-in-use-bytes":28581888,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-09-12T06:37:17.159459Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3718197962,"revision":2844,"compact-revision":-1} {"level":"info","ts":"2026-09-12T06:42:17.091577Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5468} {"level":"info","ts":"2026-09-12T06:42:17.177238Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5468,"took":"84.098541ms","hash":3642797023,"current-db-size-bytes":53198848,"current-db-size":"53 MB","current-db-size-in-use-bytes":18468864,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-09-12T06:42:17.177382Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3642797023,"revision":5468,"compact-revision":2844}