{"level":"warn","ts":"2026-09-15T11:19:23.21961Z","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-15T11:19:23.219694Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.119: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.119:2380","--initial-cluster=instance=https://162.253.55.119:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.119:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.119: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-15T11:19:23.219752Z","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-15T11:19:23.219759Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.119:2380"]} {"level":"info","ts":"2026-09-15T11:19:23.219779Z","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-15T11:19:23.220351Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"]} {"level":"info","ts":"2026-09-15T11:19:23.220417Z","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.119:2380"],"listen-peer-urls":["https://162.253.55.119:2380"],"advertise-client-urls":["https://162.253.55.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.119: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-15T11:19:23.225482Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.877956ms"} {"level":"info","ts":"2026-09-15T11:19:23.23712Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2f0e00eb3c3ee1b","cluster-id":"8e467f099f65c603"} {"level":"info","ts":"2026-09-15T11:19:23.23819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=()"} {"level":"info","ts":"2026-09-15T11:19:23.238238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became follower at term 0"} {"level":"info","ts":"2026-09-15T11:19:23.238257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2f0e00eb3c3ee1b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-15T11:19:23.238276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became follower at term 1"} {"level":"info","ts":"2026-09-15T11:19:23.238399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=(211915536236539419)"} {"level":"warn","ts":"2026-09-15T11:19:23.250696Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-15T11:19:23.253001Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-15T11:19:23.257922Z","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-15T11:19:23.260118Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2f0e00eb3c3ee1b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-15T11:19:23.26025Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2f0e00eb3c3ee1b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-15T11:19:23.260411Z","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-15T11:19:23.260508Z","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-15T11:19:23.260517Z","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-15T11:19:23.262935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=(211915536236539419)"} {"level":"info","ts":"2026-09-15T11:19:23.263137Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8e467f099f65c603","local-member-id":"2f0e00eb3c3ee1b","added-peer-id":"2f0e00eb3c3ee1b","added-peer-peer-urls":["https://162.253.55.119:2380"]} {"level":"info","ts":"2026-09-15T11:19:23.271005Z","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-15T11:19:23.271257Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.119:2380"} {"level":"info","ts":"2026-09-15T11:19:23.271284Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.119:2380"} {"level":"info","ts":"2026-09-15T11:19:23.271446Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2f0e00eb3c3ee1b","initial-advertise-peer-urls":["https://162.253.55.119:2380"],"listen-peer-urls":["https://162.253.55.119:2380"],"advertise-client-urls":["https://162.253.55.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-15T11:19:23.271467Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-15T11:19:23.940047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b is starting a new election at term 1"} {"level":"info","ts":"2026-09-15T11:19:23.940118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-15T11:19:23.940153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b received MsgPreVoteResp from 2f0e00eb3c3ee1b at term 1"} {"level":"info","ts":"2026-09-15T11:19:23.940171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became candidate at term 2"} {"level":"info","ts":"2026-09-15T11:19:23.940182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b received MsgVoteResp from 2f0e00eb3c3ee1b at term 2"} {"level":"info","ts":"2026-09-15T11:19:23.940196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became leader at term 2"} {"level":"info","ts":"2026-09-15T11:19:23.940209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2f0e00eb3c3ee1b elected leader 2f0e00eb3c3ee1b at term 2"} {"level":"info","ts":"2026-09-15T11:19:23.941652Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T11:19:23.941688Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T11:19:23.941651Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2f0e00eb3c3ee1b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.119:2379]}","request-path":"/0/members/2f0e00eb3c3ee1b/attributes","cluster-id":"8e467f099f65c603","publish-timeout":"7s"} {"level":"info","ts":"2026-09-15T11:19:23.94202Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-15T11:19:23.942075Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-15T11:19:23.941781Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T11:19:23.943472Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-15T11:19:23.944832Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.119:2379"} {"level":"info","ts":"2026-09-15T11:19:23.945567Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8e467f099f65c603","local-member-id":"2f0e00eb3c3ee1b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T11:19:23.945934Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T11:19:23.946043Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T11:19:29.927241Z","caller":"traceutil/trace.go:171","msg":"trace[1098053015] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"131.331867ms","start":"2026-09-15T11:19:29.795882Z","end":"2026-09-15T11:19:29.927214Z","steps":["trace[1098053015] 'process raft request' (duration: 130.722496ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:19:30.30634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.822083ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-15T11:19:30.306504Z","caller":"traceutil/trace.go:171","msg":"trace[1263421668] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"374.786128ms","start":"2026-09-15T11:19:29.931695Z","end":"2026-09-15T11:19:30.306481Z","steps":["trace[1263421668] 'process raft request' (duration: 186.197195ms)","trace[1263421668] 'compare' (duration: 187.480215ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:19:30.306584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:19:29.931671Z","time spent":"374.878832ms","remote":"127.0.0.1:36664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T11:19:30.325865Z","caller":"traceutil/trace.go:171","msg":"trace[2073093212] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:317; }","duration":"388.99539ms","start":"2026-09-15T11:19:29.936843Z","end":"2026-09-15T11:19:30.325839Z","steps":["trace[2073093212] 'read index received' (duration: 181.182441ms)","trace[2073093212] 'applied index is now lower than readState.Index' (duration: 207.811499ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:19:30.325882Z","caller":"traceutil/trace.go:171","msg":"trace[862582864] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"392.000098ms","start":"2026-09-15T11:19:29.933842Z","end":"2026-09-15T11:19:30.325843Z","steps":["trace[862582864] 'process raft request' (duration: 391.741785ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:19:30.325962Z","caller":"traceutil/trace.go:171","msg":"trace[1632996908] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"390.019485ms","start":"2026-09-15T11:19:29.935915Z","end":"2026-09-15T11:19:30.325934Z","steps":["trace[1632996908] 'process raft request' (duration: 389.871257ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:19:30.326054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.273316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-09-15T11:19:30.326053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.18573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-09-15T11:19:30.326101Z","caller":"traceutil/trace.go:171","msg":"trace[918291562] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:312; }","duration":"127.338669ms","start":"2026-09-15T11:19:30.19875Z","end":"2026-09-15T11:19:30.326089Z","steps":["trace[918291562] 'agreement among raft nodes before linearized reading' (duration: 127.225583ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:19:30.326114Z","caller":"traceutil/trace.go:171","msg":"trace[344171629] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:312; }","duration":"389.337258ms","start":"2026-09-15T11:19:29.936762Z","end":"2026-09-15T11:19:30.326099Z","steps":["trace[344171629] 'agreement among raft nodes before linearized reading' (duration: 389.207532ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:19:30.326177Z","caller":"traceutil/trace.go:171","msg":"trace[1351612489] transaction","detail":"{read_only:false; number_of_response:0; response_revision:311; }","duration":"390.256527ms","start":"2026-09-15T11:19:29.935663Z","end":"2026-09-15T11:19:30.32592Z","steps":["trace[1351612489] 'process raft request' (duration: 390.085258ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:19:30.326262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:19:29.93675Z","time spent":"389.501506ms","remote":"127.0.0.1:55232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":2943,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-09-15T11:19:30.326315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:19:29.935905Z","time spent":"390.113369ms","remote":"127.0.0.1:55302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T11:19:30.326058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:19:29.933826Z","time spent":"392.134175ms","remote":"127.0.0.1:55254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-15T11:19:30.326341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:19:29.935651Z","time spent":"390.645096ms","remote":"127.0.0.1:55232","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T11:19:30.486654Z","caller":"traceutil/trace.go:171","msg":"trace[788689199] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"118.09427ms","start":"2026-09-15T11:19:30.368517Z","end":"2026-09-15T11:19:30.486611Z","steps":["trace[788689199] 'process raft request' (duration: 83.574511ms)","trace[788689199] 'compare' (duration: 34.296267ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:19:30.72688Z","caller":"traceutil/trace.go:171","msg":"trace[733589460] linearizableReadLoop","detail":"{readStateIndex:325; appliedIndex:324; }","duration":"221.174711ms","start":"2026-09-15T11:19:30.505686Z","end":"2026-09-15T11:19:30.726861Z","steps":["trace[733589460] 'read index received' (duration: 131.666642ms)","trace[733589460] 'applied index is now lower than readState.Index' (duration: 89.507399ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:19:30.726972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.271516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T11:19:30.726957Z","caller":"traceutil/trace.go:171","msg":"trace[80103112] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"226.826334ms","start":"2026-09-15T11:19:30.5001Z","end":"2026-09-15T11:19:30.726926Z","steps":["trace[80103112] 'process raft request' (duration: 137.195139ms)","trace[80103112] 'compare' (duration: 89.485608ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:19:30.726997Z","caller":"traceutil/trace.go:171","msg":"trace[1029860936] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:316; }","duration":"221.344189ms","start":"2026-09-15T11:19:30.505645Z","end":"2026-09-15T11:19:30.726989Z","steps":["trace[1029860936] 'agreement among raft nodes before linearized reading' (duration: 221.282666ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:06.680323Z","caller":"traceutil/trace.go:171","msg":"trace[1523465507] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"117.305623ms","start":"2026-09-15T11:20:06.562989Z","end":"2026-09-15T11:20:06.680294Z","steps":["trace[1523465507] 'process raft request' (duration: 109.247542ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.375794Z","caller":"traceutil/trace.go:171","msg":"trace[282862703] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"356.83061ms","start":"2026-09-15T11:20:18.018928Z","end":"2026-09-15T11:20:18.375759Z","steps":["trace[282862703] 'process raft request' (duration: 356.49662ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:18.376105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.018856Z","time spent":"357.104148ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T11:20:18.533812Z","caller":"traceutil/trace.go:171","msg":"trace[1940001673] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"501.16592ms","start":"2026-09-15T11:20:18.032622Z","end":"2026-09-15T11:20:18.533788Z","steps":["trace[1940001673] 'process raft request' (duration: 500.910882ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.534062Z","caller":"traceutil/trace.go:171","msg":"trace[139901288] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"492.319375ms","start":"2026-09-15T11:20:18.041734Z","end":"2026-09-15T11:20:18.534053Z","steps":["trace[139901288] 'process raft request' (duration: 492.118049ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:18.534062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.032561Z","time spent":"501.420808ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-15T11:20:18.53416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.041718Z","time spent":"492.377777ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T11:20:18.533936Z","caller":"traceutil/trace.go:171","msg":"trace[584289155] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"492.581224ms","start":"2026-09-15T11:20:18.041341Z","end":"2026-09-15T11:20:18.533923Z","steps":["trace[584289155] 'process raft request' (duration: 492.352147ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.533763Z","caller":"traceutil/trace.go:171","msg":"trace[2075783074] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"506.740293ms","start":"2026-09-15T11:20:18.026983Z","end":"2026-09-15T11:20:18.533723Z","steps":["trace[2075783074] 'process raft request' (duration: 483.41378ms)","trace[2075783074] 'compare' (duration: 22.965542ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:20:18.534386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.041302Z","time spent":"493.017198ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T11:20:18.534488Z","caller":"traceutil/trace.go:171","msg":"trace[1858590261] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"486.370591ms","start":"2026-09-15T11:20:18.048049Z","end":"2026-09-15T11:20:18.53442Z","steps":["trace[1858590261] 'process raft request' (duration: 486.020401ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.534574Z","caller":"traceutil/trace.go:171","msg":"trace[23288933] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"490.588754ms","start":"2026-09-15T11:20:18.043973Z","end":"2026-09-15T11:20:18.534561Z","steps":["trace[23288933] 'process raft request' (duration: 490.025755ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.534657Z","caller":"traceutil/trace.go:171","msg":"trace[49733784] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"308.924967ms","start":"2026-09-15T11:20:18.225711Z","end":"2026-09-15T11:20:18.534636Z","steps":["trace[49733784] 'process raft request' (duration: 308.783083ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:18.534706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.043931Z","time spent":"490.746378ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-15T11:20:18.534745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.225671Z","time spent":"309.02759ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T11:20:18.534788Z","caller":"traceutil/trace.go:171","msg":"trace[1422113123] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"464.536226ms","start":"2026-09-15T11:20:18.070241Z","end":"2026-09-15T11:20:18.534777Z","steps":["trace[1422113123] 'process raft request' (duration: 464.010659ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:18.534654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.048027Z","time spent":"486.537118ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T11:20:18.534881Z","caller":"traceutil/trace.go:171","msg":"trace[233026023] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"486.737084ms","start":"2026-09-15T11:20:18.048133Z","end":"2026-09-15T11:20:18.53487Z","steps":["trace[233026023] 'process raft request' (duration: 486.055922ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:18.53493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.047934Z","time spent":"486.973791ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T11:20:18.534975Z","caller":"traceutil/trace.go:171","msg":"trace[1195281039] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"424.019991ms","start":"2026-09-15T11:20:18.110943Z","end":"2026-09-15T11:20:18.534963Z","steps":["trace[1195281039] 'process raft request' (duration: 423.454583ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.534928Z","caller":"traceutil/trace.go:171","msg":"trace[1600951860] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"452.806993ms","start":"2026-09-15T11:20:18.082044Z","end":"2026-09-15T11:20:18.534851Z","steps":["trace[1600951860] 'process raft request' (duration: 452.276606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:18.535043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.110862Z","time spent":"424.148855ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-15T11:20:18.535046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.082022Z","time spent":"453.0016ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-15T11:20:18.534844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.070213Z","time spent":"464.605568ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-15T11:20:18.535055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:18.026942Z","time spent":"507.495936ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T11:20:18.539279Z","caller":"traceutil/trace.go:171","msg":"trace[941494793] transaction","detail":"{read_only:false; number_of_response:1; response_revision:575; }","duration":"153.221985ms","start":"2026-09-15T11:20:18.38604Z","end":"2026-09-15T11:20:18.539262Z","steps":["trace[941494793] 'process raft request' (duration: 153.124172ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.539859Z","caller":"traceutil/trace.go:171","msg":"trace[1437820075] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"155.95501ms","start":"2026-09-15T11:20:18.383831Z","end":"2026-09-15T11:20:18.539786Z","steps":["trace[1437820075] 'process raft request' (duration: 154.540826ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.541228Z","caller":"traceutil/trace.go:171","msg":"trace[1026600926] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"155.396332ms","start":"2026-09-15T11:20:18.385813Z","end":"2026-09-15T11:20:18.541209Z","steps":["trace[1026600926] 'process raft request' (duration: 152.854294ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.685515Z","caller":"traceutil/trace.go:171","msg":"trace[819682727] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"124.333959ms","start":"2026-09-15T11:20:18.561148Z","end":"2026-09-15T11:20:18.685482Z","steps":["trace[819682727] 'process raft request' (duration: 72.286688ms)","trace[819682727] 'compare' (duration: 51.778703ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:20:18.68554Z","caller":"traceutil/trace.go:171","msg":"trace[1226318001] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"124.272297ms","start":"2026-09-15T11:20:18.561241Z","end":"2026-09-15T11:20:18.685514Z","steps":["trace[1226318001] 'process raft request' (duration: 124.148214ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.685573Z","caller":"traceutil/trace.go:171","msg":"trace[1217710978] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"124.254896ms","start":"2026-09-15T11:20:18.561297Z","end":"2026-09-15T11:20:18.685552Z","steps":["trace[1217710978] 'process raft request' (duration: 124.129323ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.686882Z","caller":"traceutil/trace.go:171","msg":"trace[768560667] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"119.362457ms","start":"2026-09-15T11:20:18.566568Z","end":"2026-09-15T11:20:18.685931Z","steps":["trace[768560667] 'process raft request' (duration: 118.984754ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.687131Z","caller":"traceutil/trace.go:171","msg":"trace[823251849] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"114.264589ms","start":"2026-09-15T11:20:18.571704Z","end":"2026-09-15T11:20:18.685968Z","steps":["trace[823251849] 'process raft request' (duration: 114.190337ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.686498Z","caller":"traceutil/trace.go:171","msg":"trace[1327282258] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"125.080153ms","start":"2026-09-15T11:20:18.561391Z","end":"2026-09-15T11:20:18.686471Z","steps":["trace[1327282258] 'process raft request' (duration: 124.069942ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.68824Z","caller":"traceutil/trace.go:171","msg":"trace[1046920340] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"119.278214ms","start":"2026-09-15T11:20:18.568932Z","end":"2026-09-15T11:20:18.688211Z","steps":["trace[1046920340] 'process raft request' (duration: 116.904871ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.688402Z","caller":"traceutil/trace.go:171","msg":"trace[1790801762] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"125.850816ms","start":"2026-09-15T11:20:18.562455Z","end":"2026-09-15T11:20:18.688306Z","steps":["trace[1790801762] 'process raft request' (duration: 123.044589ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.691119Z","caller":"traceutil/trace.go:171","msg":"trace[355091321] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"114.00253ms","start":"2026-09-15T11:20:18.577096Z","end":"2026-09-15T11:20:18.691099Z","steps":["trace[355091321] 'process raft request' (duration: 110.775241ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:18.691451Z","caller":"traceutil/trace.go:171","msg":"trace[1196957978] transaction","detail":"{read_only:false; number_of_response:1; response_revision:585; }","duration":"102.415653ms","start":"2026-09-15T11:20:18.58902Z","end":"2026-09-15T11:20:18.691435Z","steps":["trace[1196957978] 'process raft request' (duration: 101.160774ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:25.187073Z","caller":"traceutil/trace.go:171","msg":"trace[797864928] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"132.969572ms","start":"2026-09-15T11:20:25.054077Z","end":"2026-09-15T11:20:25.187046Z","steps":["trace[797864928] 'process raft request' (duration: 132.417105ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:25.438686Z","caller":"traceutil/trace.go:171","msg":"trace[635027758] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"352.454026ms","start":"2026-09-15T11:20:25.086204Z","end":"2026-09-15T11:20:25.438658Z","steps":["trace[635027758] 'process raft request' (duration: 352.235219ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:25.438846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:25.086183Z","time spent":"352.583839ms","remote":"127.0.0.1:55232","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-15T11:20:25.459706Z","caller":"traceutil/trace.go:171","msg":"trace[427434272] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"196.566439ms","start":"2026-09-15T11:20:25.263113Z","end":"2026-09-15T11:20:25.45968Z","steps":["trace[427434272] 'process raft request' (duration: 196.412293ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:26.323267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.677642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T11:20:26.323357Z","caller":"traceutil/trace.go:171","msg":"trace[469618509] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:671; }","duration":"547.807245ms","start":"2026-09-15T11:20:25.775529Z","end":"2026-09-15T11:20:26.323336Z","steps":["trace[469618509] 'range keys from in-memory index tree' (duration: 547.580489ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:26.323402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:25.77551Z","time spent":"547.880658ms","remote":"127.0.0.1:36584","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-15T11:20:26.323547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.879939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T11:20:26.323627Z","caller":"traceutil/trace.go:171","msg":"trace[56675445] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:671; }","duration":"526.051674ms","start":"2026-09-15T11:20:25.797558Z","end":"2026-09-15T11:20:26.32361Z","steps":["trace[56675445] 'count revisions from in-memory index tree' (duration: 525.820618ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:26.323675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:25.797543Z","time spent":"526.116876ms","remote":"127.0.0.1:36680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-09-15T11:20:26.348781Z","caller":"traceutil/trace.go:171","msg":"trace[652578747] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"449.465634ms","start":"2026-09-15T11:20:25.899282Z","end":"2026-09-15T11:20:26.348748Z","steps":["trace[652578747] 'process raft request' (duration: 448.815484ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:26.348808Z","caller":"traceutil/trace.go:171","msg":"trace[1917941268] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"306.493132ms","start":"2026-09-15T11:20:26.042288Z","end":"2026-09-15T11:20:26.348781Z","steps":["trace[1917941268] 'read index received' (duration: 305.537514ms)","trace[1917941268] 'applied index is now lower than readState.Index' (duration: 953.058µs)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:20:26.348945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.643487ms","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-15T11:20:26.348958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:25.899256Z","time spent":"449.609897ms","remote":"127.0.0.1:36692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T11:20:26.349124Z","caller":"traceutil/trace.go:171","msg":"trace[1739412561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:672; }","duration":"306.75608ms","start":"2026-09-15T11:20:26.042232Z","end":"2026-09-15T11:20:26.348988Z","steps":["trace[1739412561] 'agreement among raft nodes before linearized reading' (duration: 306.602465ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:26.349145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.98964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-09-15T11:20:26.349187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:26.042211Z","time spent":"306.949114ms","remote":"127.0.0.1:55302","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-15T11:20:26.349215Z","caller":"traceutil/trace.go:171","msg":"trace[473998648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:672; }","duration":"287.104483ms","start":"2026-09-15T11:20:26.062092Z","end":"2026-09-15T11:20:26.349197Z","steps":["trace[473998648] 'agreement among raft nodes before linearized reading' (duration: 286.99008ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:38.848979Z","caller":"traceutil/trace.go:171","msg":"trace[539715142] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"110.754257ms","start":"2026-09-15T11:20:38.738189Z","end":"2026-09-15T11:20:38.848943Z","steps":["trace[539715142] 'process raft request' (duration: 110.4694ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:20:38.912108Z","caller":"traceutil/trace.go:171","msg":"trace[2134459195] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"116.565278ms","start":"2026-09-15T11:20:38.795508Z","end":"2026-09-15T11:20:38.912073Z","steps":["trace[2134459195] 'process raft request' (duration: 96.487977ms)","trace[2134459195] 'compare' (duration: 19.854496ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:20:45.531272Z","caller":"traceutil/trace.go:171","msg":"trace[2052385350] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"346.414153ms","start":"2026-09-15T11:20:45.184832Z","end":"2026-09-15T11:20:45.531246Z","steps":["trace[2052385350] 'process raft request' (duration: 346.250639ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:20:45.531439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:20:45.18481Z","time spent":"346.543586ms","remote":"127.0.0.1:55232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T11:21:16.791895Z","caller":"traceutil/trace.go:171","msg":"trace[703146619] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"367.974788ms","start":"2026-09-15T11:21:16.423843Z","end":"2026-09-15T11:21:16.791817Z","steps":["trace[703146619] 'process raft request' (duration: 367.718423ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:21:16.792235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:21:16.423796Z","time spent":"368.250653ms","remote":"127.0.0.1:55302","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-15T11:21:38.663743Z","caller":"traceutil/trace.go:171","msg":"trace[1448977996] transaction","detail":"{read_only:false; response_revision:1506; number_of_response:1; }","duration":"123.45543ms","start":"2026-09-15T11:21:38.540266Z","end":"2026-09-15T11:21:38.663722Z","steps":["trace[1448977996] 'process raft request' (duration: 123.335518ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:22:05.259266Z","caller":"traceutil/trace.go:171","msg":"trace[364383725] linearizableReadLoop","detail":"{readStateIndex:1990; appliedIndex:1989; }","duration":"229.308843ms","start":"2026-09-15T11:22:05.029934Z","end":"2026-09-15T11:22:05.259243Z","steps":["trace[364383725] 'read index received' (duration: 229.164801ms)","trace[364383725] 'applied index is now lower than readState.Index' (duration: 142.542µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:22:05.259302Z","caller":"traceutil/trace.go:171","msg":"trace[1012632539] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"265.45892ms","start":"2026-09-15T11:22:04.993818Z","end":"2026-09-15T11:22:05.259277Z","steps":["trace[1012632539] 'process raft request' (duration: 265.289637ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:05.259466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.521016ms","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-15T11:22:05.259538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.305005ms","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-15T11:22:05.259643Z","caller":"traceutil/trace.go:171","msg":"trace[258665657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1917; }","duration":"167.444387ms","start":"2026-09-15T11:22:05.092191Z","end":"2026-09-15T11:22:05.259635Z","steps":["trace[258665657] 'agreement among raft nodes before linearized reading' (duration: 167.308755ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:22:05.259629Z","caller":"traceutil/trace.go:171","msg":"trace[1082878287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1917; }","duration":"229.679879ms","start":"2026-09-15T11:22:05.029885Z","end":"2026-09-15T11:22:05.259564Z","steps":["trace[1082878287] 'agreement among raft nodes before linearized reading' (duration: 229.469316ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:05.476145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.88506ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T11:22:05.476252Z","caller":"traceutil/trace.go:171","msg":"trace[2015388227] linearizableReadLoop","detail":"{readStateIndex:1992; appliedIndex:1991; }","duration":"190.432734ms","start":"2026-09-15T11:22:05.285801Z","end":"2026-09-15T11:22:05.476234Z","steps":["trace[2015388227] 'read index received' (duration: 75.435092ms)","trace[2015388227] 'applied index is now lower than readState.Index' (duration: 114.995662ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:22:05.476309Z","caller":"traceutil/trace.go:171","msg":"trace[592752392] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"211.923066ms","start":"2026-09-15T11:22:05.26436Z","end":"2026-09-15T11:22:05.476283Z","steps":["trace[592752392] 'process raft request' (duration: 96.803882ms)","trace[592752392] 'compare' (duration: 114.756158ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:22:05.476451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.651967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53d57578-cba1-4cfb-99c8-8c4322365119\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-15T11:22:05.476482Z","caller":"traceutil/trace.go:171","msg":"trace[229193744] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-53d57578-cba1-4cfb-99c8-8c4322365119; range_end:; response_count:1; response_revision:1919; }","duration":"190.704348ms","start":"2026-09-15T11:22:05.285768Z","end":"2026-09-15T11:22:05.476472Z","steps":["trace[229193744] 'agreement among raft nodes before linearized reading' (duration: 190.550996ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:05.476831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.054021ms","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-15T11:22:05.476945Z","caller":"traceutil/trace.go:171","msg":"trace[1516920773] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1919; }","duration":"103.130532ms","start":"2026-09-15T11:22:05.373752Z","end":"2026-09-15T11:22:05.476883Z","steps":["trace[1516920773] 'agreement among raft nodes before linearized reading' (duration: 102.919459ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:22:05.778059Z","caller":"traceutil/trace.go:171","msg":"trace[1189051257] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"198.382361ms","start":"2026-09-15T11:22:05.579649Z","end":"2026-09-15T11:22:05.778031Z","steps":["trace[1189051257] 'process raft request' (duration: 198.100926ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:10.408902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.539799ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-15T11:22:10.409051Z","caller":"traceutil/trace.go:171","msg":"trace[1136207507] linearizableReadLoop","detail":"{readStateIndex:2044; appliedIndex:2042; }","duration":"140.217497ms","start":"2026-09-15T11:22:10.268814Z","end":"2026-09-15T11:22:10.409031Z","steps":["trace[1136207507] 'read index received' (duration: 19.467545ms)","trace[1136207507] 'applied index is now lower than readState.Index' (duration: 120.748742ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:22:10.40915Z","caller":"traceutil/trace.go:171","msg":"trace[1805477847] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"144.595296ms","start":"2026-09-15T11:22:10.264531Z","end":"2026-09-15T11:22:10.409127Z","steps":["trace[1805477847] 'process raft request' (duration: 144.456404ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:22:10.409167Z","caller":"traceutil/trace.go:171","msg":"trace[304972603] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"153.032568ms","start":"2026-09-15T11:22:10.256085Z","end":"2026-09-15T11:22:10.409118Z","steps":["trace[304972603] 'process raft request' (duration: 32.215454ms)","trace[304972603] 'compare' (duration: 120.379967ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:22:10.409353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.522732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:10374"} {"level":"info","ts":"2026-09-15T11:22:10.409408Z","caller":"traceutil/trace.go:171","msg":"trace[1255502830] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1969; }","duration":"140.586363ms","start":"2026-09-15T11:22:10.268808Z","end":"2026-09-15T11:22:10.409394Z","steps":["trace[1255502830] 'agreement among raft nodes before linearized reading' (duration: 140.322319ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:10.409423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.537964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-09-15T11:22:10.409553Z","caller":"traceutil/trace.go:171","msg":"trace[276140265] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1969; }","duration":"135.684666ms","start":"2026-09-15T11:22:10.273841Z","end":"2026-09-15T11:22:10.409525Z","steps":["trace[276140265] 'agreement among raft nodes before linearized reading' (duration: 135.388871ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:22:21.889861Z","caller":"traceutil/trace.go:171","msg":"trace[762561193] linearizableReadLoop","detail":"{readStateIndex:2132; appliedIndex:2131; }","duration":"151.474898ms","start":"2026-09-15T11:22:21.738357Z","end":"2026-09-15T11:22:21.889832Z","steps":["trace[762561193] 'read index received' (duration: 151.206054ms)","trace[762561193] 'applied index is now lower than readState.Index' (duration: 267.374µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:22:21.88991Z","caller":"traceutil/trace.go:171","msg":"trace[352321465] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"155.498179ms","start":"2026-09-15T11:22:21.734376Z","end":"2026-09-15T11:22:21.889874Z","steps":["trace[352321465] 'process raft request' (duration: 155.204084ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:21.89011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.733552ms","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-15T11:22:21.89015Z","caller":"traceutil/trace.go:171","msg":"trace[682769435] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2055; }","duration":"151.847863ms","start":"2026-09-15T11:22:21.73829Z","end":"2026-09-15T11:22:21.890138Z","steps":["trace[682769435] 'agreement among raft nodes before linearized reading' (duration: 151.704471ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:21.890173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.41424ms","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-15T11:22:21.89021Z","caller":"traceutil/trace.go:171","msg":"trace[535321873] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2055; }","duration":"140.47832ms","start":"2026-09-15T11:22:21.749715Z","end":"2026-09-15T11:22:21.890193Z","steps":["trace[535321873] 'agreement among raft nodes before linearized reading' (duration: 140.366939ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:21.890254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.397601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T11:22:21.890332Z","caller":"traceutil/trace.go:171","msg":"trace[222862577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2055; }","duration":"113.516252ms","start":"2026-09-15T11:22:21.776786Z","end":"2026-09-15T11:22:21.890302Z","steps":["trace[222862577] 'agreement among raft nodes before linearized reading' (duration: 113.327749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:21.890437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.468538ms","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-15T11:22:21.890547Z","caller":"traceutil/trace.go:171","msg":"trace[717903037] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2055; }","duration":"128.622591ms","start":"2026-09-15T11:22:21.761896Z","end":"2026-09-15T11:22:21.890519Z","steps":["trace[717903037] 'agreement among raft nodes before linearized reading' (duration: 128.259096ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:41.769239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.850234ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T11:22:41.769505Z","caller":"traceutil/trace.go:171","msg":"trace[245061819] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"136.701265ms","start":"2026-09-15T11:22:41.632716Z","end":"2026-09-15T11:22:41.769418Z","steps":["trace[245061819] 'process raft request' (duration: 29.541607ms)","trace[245061819] 'compare' (duration: 106.384057ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:22:42.149837Z","caller":"traceutil/trace.go:171","msg":"trace[1320421988] linearizableReadLoop","detail":"{readStateIndex:2257; appliedIndex:2256; }","duration":"116.460669ms","start":"2026-09-15T11:22:42.033345Z","end":"2026-09-15T11:22:42.149806Z","steps":["trace[1320421988] 'read index received' (duration: 100.857794ms)","trace[1320421988] 'applied index is now lower than readState.Index' (duration: 15.601275ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:22:42.149932Z","caller":"traceutil/trace.go:171","msg":"trace[681619992] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"129.721581ms","start":"2026-09-15T11:22:42.020181Z","end":"2026-09-15T11:22:42.149903Z","steps":["trace[681619992] 'process raft request' (duration: 113.998865ms)","trace[681619992] 'compare' (duration: 15.455703ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:22:42.150131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.789114ms","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-15T11:22:42.150688Z","caller":"traceutil/trace.go:171","msg":"trace[2019067422] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2175; }","duration":"117.059957ms","start":"2026-09-15T11:22:42.033258Z","end":"2026-09-15T11:22:42.150318Z","steps":["trace[2019067422] 'agreement among raft nodes before linearized reading' (duration: 116.650901ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:42.523775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.994786ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T11:22:42.524376Z","caller":"traceutil/trace.go:171","msg":"trace[2071044712] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"119.832669ms","start":"2026-09-15T11:22:42.404524Z","end":"2026-09-15T11:22:42.524357Z","steps":["trace[2071044712] 'process raft request' (duration: 119.723236ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:22:42.524663Z","caller":"traceutil/trace.go:171","msg":"trace[775311852] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"309.28257ms","start":"2026-09-15T11:22:42.215343Z","end":"2026-09-15T11:22:42.524625Z","steps":["trace[775311852] 'process raft request' (duration: 130.33761ms)","trace[775311852] 'compare' (duration: 177.670582ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:22:42.525408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:22:42.21532Z","time spent":"309.896908ms","remote":"127.0.0.1:55302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T11:22:42.701543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.151367ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-15T11:22:42.701696Z","caller":"traceutil/trace.go:171","msg":"trace[2024987044] linearizableReadLoop","detail":"{readStateIndex:2260; appliedIndex:2259; }","duration":"166.726364ms","start":"2026-09-15T11:22:42.534937Z","end":"2026-09-15T11:22:42.701664Z","steps":["trace[2024987044] 'read index received' (duration: 29.385124ms)","trace[2024987044] 'applied index is now lower than readState.Index' (duration: 137.33965ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:22:42.701865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.892137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T11:22:42.702097Z","caller":"traceutil/trace.go:171","msg":"trace[547792918] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2177; }","duration":"167.14084ms","start":"2026-09-15T11:22:42.53493Z","end":"2026-09-15T11:22:42.702071Z","steps":["trace[547792918] 'agreement among raft nodes before linearized reading' (duration: 166.838056ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:22:42.71169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.097871ms","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-15T11:22:42.711749Z","caller":"traceutil/trace.go:171","msg":"trace[1556713873] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2178; }","duration":"122.199611ms","start":"2026-09-15T11:22:42.589533Z","end":"2026-09-15T11:22:42.711733Z","steps":["trace[1556713873] 'agreement among raft nodes before linearized reading' (duration: 122.016689ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:22:43.079775Z","caller":"traceutil/trace.go:171","msg":"trace[317270531] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"158.984369ms","start":"2026-09-15T11:22:42.920764Z","end":"2026-09-15T11:22:43.079749Z","steps":["trace[317270531] 'process raft request' (duration: 158.818147ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:24:23.375545Z","caller":"traceutil/trace.go:171","msg":"trace[1254917970] transaction","detail":"{read_only:false; response_revision:2824; number_of_response:1; }","duration":"144.645708ms","start":"2026-09-15T11:24:23.230879Z","end":"2026-09-15T11:24:23.375525Z","steps":["trace[1254917970] 'process raft request' (duration: 144.316044ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:24:23.642542Z","caller":"traceutil/trace.go:171","msg":"trace[146966390] transaction","detail":"{read_only:false; response_revision:2825; number_of_response:1; }","duration":"199.078269ms","start":"2026-09-15T11:24:23.443437Z","end":"2026-09-15T11:24:23.642515Z","steps":["trace[146966390] 'process raft request' (duration: 175.344939ms)","trace[146966390] 'compare' (duration: 23.27566ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:28:53.362508Z","caller":"traceutil/trace.go:171","msg":"trace[76880898] linearizableReadLoop","detail":"{readStateIndex:5119; appliedIndex:5118; }","duration":"148.582023ms","start":"2026-09-15T11:28:53.213902Z","end":"2026-09-15T11:28:53.362484Z","steps":["trace[76880898] 'read index received' (duration: 148.361678ms)","trace[76880898] 'applied index is now lower than readState.Index' (duration: 219.255µs)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:28:53.362638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.720896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T11:28:53.362621Z","caller":"traceutil/trace.go:171","msg":"trace[1979487460] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"192.497488ms","start":"2026-09-15T11:28:53.170083Z","end":"2026-09-15T11:28:53.362581Z","steps":["trace[1979487460] 'process raft request' (duration: 192.248903ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:28:53.362675Z","caller":"traceutil/trace.go:171","msg":"trace[1738249599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4929; }","duration":"149.115985ms","start":"2026-09-15T11:28:53.213546Z","end":"2026-09-15T11:28:53.362662Z","steps":["trace[1738249599] 'agreement among raft nodes before linearized reading' (duration: 149.037494ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:28:53.495304Z","caller":"traceutil/trace.go:171","msg":"trace[281062171] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"125.998013ms","start":"2026-09-15T11:28:53.369279Z","end":"2026-09-15T11:28:53.495277Z","steps":["trace[281062171] 'process raft request' (duration: 125.159075ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:28:53.542335Z","caller":"traceutil/trace.go:171","msg":"trace[570257206] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"172.812418ms","start":"2026-09-15T11:28:53.369471Z","end":"2026-09-15T11:28:53.542283Z","steps":["trace[570257206] 'process raft request' (duration: 172.43135ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:28:53.542591Z","caller":"traceutil/trace.go:171","msg":"trace[28119216] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"170.566051ms","start":"2026-09-15T11:28:53.371967Z","end":"2026-09-15T11:28:53.542533Z","steps":["trace[28119216] 'process raft request' (duration: 170.222254ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:28:58.798677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.140066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T11:28:58.79901Z","caller":"traceutil/trace.go:171","msg":"trace[1186898769] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"315.757345ms","start":"2026-09-15T11:28:58.483215Z","end":"2026-09-15T11:28:58.798972Z","steps":["trace[1186898769] 'process raft request' (duration: 106.950884ms)","trace[1186898769] 'compare' (duration: 207.942772ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:28:58.799035Z","caller":"traceutil/trace.go:171","msg":"trace[902081914] linearizableReadLoop","detail":"{readStateIndex:5219; appliedIndex:5218; }","duration":"128.344366ms","start":"2026-09-15T11:28:58.670634Z","end":"2026-09-15T11:28:58.798978Z","steps":["trace[902081914] 'read index received' (duration: 30.2µs)","trace[902081914] 'applied index is now lower than readState.Index' (duration: 128.312406ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T11:28:58.799215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T11:28:58.483197Z","time spent":"315.902207ms","remote":"127.0.0.1:55302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T11:28:58.799368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.727704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-66bcc77bc5-prrnw\" ","response":"range_response_count:1 size:11257"} {"level":"info","ts":"2026-09-15T11:28:58.799416Z","caller":"traceutil/trace.go:171","msg":"trace[623551795] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-66bcc77bc5-prrnw; range_end:; response_count:1; response_revision:5027; }","duration":"128.803165ms","start":"2026-09-15T11:28:58.670599Z","end":"2026-09-15T11:28:58.799403Z","steps":["trace[623551795] 'agreement among raft nodes before linearized reading' (duration: 128.474049ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:28:58.827404Z","caller":"traceutil/trace.go:171","msg":"trace[907752553] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"155.580189ms","start":"2026-09-15T11:28:58.671792Z","end":"2026-09-15T11:28:58.827372Z","steps":["trace[907752553] 'process raft request' (duration: 155.425006ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:28:58.925917Z","caller":"traceutil/trace.go:171","msg":"trace[1851961229] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"173.45086ms","start":"2026-09-15T11:28:58.75244Z","end":"2026-09-15T11:28:58.925891Z","steps":["trace[1851961229] 'process raft request' (duration: 173.193905ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:28:58.926205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.711113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T11:28:58.926253Z","caller":"traceutil/trace.go:171","msg":"trace[1929217846] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:5030; }","duration":"199.783415ms","start":"2026-09-15T11:28:58.726457Z","end":"2026-09-15T11:28:58.92624Z","steps":["trace[1929217846] 'agreement among raft nodes before linearized reading' (duration: 199.672511ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:28:58.926239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.936334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-15T11:28:58.9263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.049503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f23578b6-4dbc-4efc-8cc5-6cf912e7d402\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-15T11:28:58.92633Z","caller":"traceutil/trace.go:171","msg":"trace[323250603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5030; }","duration":"150.117467ms","start":"2026-09-15T11:28:58.776192Z","end":"2026-09-15T11:28:58.926309Z","steps":["trace[323250603] 'agreement among raft nodes before linearized reading' (duration: 149.896532ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:28:58.926368Z","caller":"traceutil/trace.go:171","msg":"trace[1547205188] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f23578b6-4dbc-4efc-8cc5-6cf912e7d402; range_end:; response_count:1; response_revision:5030; }","duration":"160.194956ms","start":"2026-09-15T11:28:58.766155Z","end":"2026-09-15T11:28:58.92635Z","steps":["trace[1547205188] 'agreement among raft nodes before linearized reading' (duration: 159.95278ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:28:58.926586Z","caller":"traceutil/trace.go:171","msg":"trace[755577187] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"111.14546ms","start":"2026-09-15T11:28:58.814953Z","end":"2026-09-15T11:28:58.926098Z","steps":["trace[755577187] 'process raft request' (duration: 110.871014ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:28:58.926608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.339969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-15T11:28:58.926778Z","caller":"traceutil/trace.go:171","msg":"trace[639418808] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5030; }","duration":"232.525152ms","start":"2026-09-15T11:28:58.694218Z","end":"2026-09-15T11:28:58.926744Z","steps":["trace[639418808] 'agreement among raft nodes before linearized reading' (duration: 232.173205ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:28:58.926093Z","caller":"traceutil/trace.go:171","msg":"trace[131829951] linearizableReadLoop","detail":"{readStateIndex:5221; appliedIndex:5219; }","duration":"126.876105ms","start":"2026-09-15T11:28:58.799188Z","end":"2026-09-15T11:28:58.926064Z","steps":["trace[131829951] 'read index received' (duration: 28.097072ms)","trace[131829951] 'applied index is now lower than readState.Index' (duration: 98.776483ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:28:59.303685Z","caller":"traceutil/trace.go:171","msg":"trace[1155941955] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"142.749811ms","start":"2026-09-15T11:28:59.160903Z","end":"2026-09-15T11:28:59.303653Z","steps":["trace[1155941955] 'process raft request' (duration: 80.477804ms)","trace[1155941955] 'compare' (duration: 62.126714ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:29:15.049562Z","caller":"traceutil/trace.go:171","msg":"trace[1097515347] transaction","detail":"{read_only:false; response_revision:5228; number_of_response:1; }","duration":"108.697979ms","start":"2026-09-15T11:29:14.940831Z","end":"2026-09-15T11:29:15.049529Z","steps":["trace[1097515347] 'process raft request' (duration: 32.481421ms)","trace[1097515347] 'compare' (duration: 76.012084ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:29:15.050223Z","caller":"traceutil/trace.go:171","msg":"trace[81399845] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"107.921283ms","start":"2026-09-15T11:29:14.942282Z","end":"2026-09-15T11:29:15.050203Z","steps":["trace[81399845] 'process raft request' (duration: 107.190418ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:29:15.050293Z","caller":"traceutil/trace.go:171","msg":"trace[1738374991] linearizableReadLoop","detail":"{readStateIndex:5428; appliedIndex:5425; }","duration":"101.315349ms","start":"2026-09-15T11:29:14.948944Z","end":"2026-09-15T11:29:15.050259Z","steps":["trace[1738374991] 'read index received' (duration: 24.413467ms)","trace[1738374991] 'applied index is now lower than readState.Index' (duration: 76.900382ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T11:29:15.050497Z","caller":"traceutil/trace.go:171","msg":"trace[363676709] transaction","detail":"{read_only:false; response_revision:5230; number_of_response:1; }","duration":"107.499704ms","start":"2026-09-15T11:29:14.942757Z","end":"2026-09-15T11:29:15.050256Z","steps":["trace[363676709] 'process raft request' (duration: 107.308749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T11:29:15.052688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.708207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-09-15T11:29:15.052802Z","caller":"traceutil/trace.go:171","msg":"trace[45958813] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5231; }","duration":"103.89057ms","start":"2026-09-15T11:29:14.948881Z","end":"2026-09-15T11:29:15.052771Z","steps":["trace[45958813] 'agreement among raft nodes before linearized reading' (duration: 101.498853ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T11:29:23.968202Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2827} {"level":"info","ts":"2026-09-15T11:29:24.048962Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2827,"took":"79.254975ms","hash":916344457,"current-db-size-bytes":52322304,"current-db-size":"52 MB","current-db-size-in-use-bytes":27619328,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-15T11:29:24.049026Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":916344457,"revision":2827,"compact-revision":-1} {"level":"info","ts":"2026-09-15T11:34:23.977826Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5292} {"level":"info","ts":"2026-09-15T11:34:24.065504Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5292,"took":"86.112339ms","hash":599536934,"current-db-size-bytes":52322304,"current-db-size":"52 MB","current-db-size-in-use-bytes":18759680,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-15T11:34:24.065567Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":599536934,"revision":5292,"compact-revision":2827}