{"level":"warn","ts":"2026-09-15T02:19:33.916636Z","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-15T02:19:33.916719Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.115: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.115:2380","--initial-cluster=instance=https://162.253.55.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.115: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-15T02:19:33.91678Z","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-15T02:19:33.916788Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.115:2380"]} {"level":"info","ts":"2026-09-15T02:19:33.916816Z","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-15T02:19:33.917444Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.115:2379"]} {"level":"info","ts":"2026-09-15T02:19:33.917545Z","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.115:2380"],"listen-peer-urls":["https://162.253.55.115:2380"],"advertise-client-urls":["https://162.253.55.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.115: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-15T02:19:33.923763Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.940477ms"} {"level":"info","ts":"2026-09-15T02:19:33.935613Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3fd97315619643d2","cluster-id":"5ce44a81422ca797"} {"level":"info","ts":"2026-09-15T02:19:33.935709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 switched to configuration voters=()"} {"level":"info","ts":"2026-09-15T02:19:33.93573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 became follower at term 0"} {"level":"info","ts":"2026-09-15T02:19:33.935741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3fd97315619643d2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-15T02:19:33.93575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 became follower at term 1"} {"level":"info","ts":"2026-09-15T02:19:33.935783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 switched to configuration voters=(4600835030004417490)"} {"level":"warn","ts":"2026-09-15T02:19:33.946681Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-15T02:19:33.948689Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-15T02:19:33.949779Z","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-15T02:19:33.951602Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3fd97315619643d2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-15T02:19:33.952229Z","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-15T02:19:33.952218Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3fd97315619643d2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-15T02:19:33.952332Z","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-15T02:19:33.952341Z","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-15T02:19:33.954143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 switched to configuration voters=(4600835030004417490)"} {"level":"info","ts":"2026-09-15T02:19:33.954282Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5ce44a81422ca797","local-member-id":"3fd97315619643d2","added-peer-id":"3fd97315619643d2","added-peer-peer-urls":["https://162.253.55.115:2380"]} {"level":"info","ts":"2026-09-15T02:19:33.955386Z","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-15T02:19:33.955468Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.115:2380"} {"level":"info","ts":"2026-09-15T02:19:33.955497Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.115:2380"} {"level":"info","ts":"2026-09-15T02:19:33.955609Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3fd97315619643d2","initial-advertise-peer-urls":["https://162.253.55.115:2380"],"listen-peer-urls":["https://162.253.55.115:2380"],"advertise-client-urls":["https://162.253.55.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-15T02:19:33.955647Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-15T02:19:34.936872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 is starting a new election at term 1"} {"level":"info","ts":"2026-09-15T02:19:34.936958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-15T02:19:34.937009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 received MsgPreVoteResp from 3fd97315619643d2 at term 1"} {"level":"info","ts":"2026-09-15T02:19:34.937036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 became candidate at term 2"} {"level":"info","ts":"2026-09-15T02:19:34.937054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 received MsgVoteResp from 3fd97315619643d2 at term 2"} {"level":"info","ts":"2026-09-15T02:19:34.937071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3fd97315619643d2 became leader at term 2"} {"level":"info","ts":"2026-09-15T02:19:34.937086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3fd97315619643d2 elected leader 3fd97315619643d2 at term 2"} {"level":"info","ts":"2026-09-15T02:19:34.938569Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:19:34.939547Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3fd97315619643d2","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.115:2379]}","request-path":"/0/members/3fd97315619643d2/attributes","cluster-id":"5ce44a81422ca797","publish-timeout":"7s"} {"level":"info","ts":"2026-09-15T02:19:34.939689Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T02:19:34.939888Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T02:19:34.940167Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5ce44a81422ca797","local-member-id":"3fd97315619643d2","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:19:34.94033Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:19:34.940381Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:19:34.941002Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-15T02:19:34.941045Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-15T02:19:34.943151Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.115:2379"} {"level":"info","ts":"2026-09-15T02:19:34.944338Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-15T02:19:49.055069Z","caller":"traceutil/trace.go:171","msg":"trace[2070483889] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"317.827943ms","start":"2026-09-15T02:19:48.7372Z","end":"2026-09-15T02:19:49.055028Z","steps":["trace[2070483889] 'process raft request' (duration: 303.939454ms)","trace[2070483889] 'compare' (duration: 13.635047ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:19:49.055235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.12289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-15T02:19:49.055331Z","caller":"traceutil/trace.go:171","msg":"trace[1823784997] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:407; }","duration":"126.300951ms","start":"2026-09-15T02:19:48.929013Z","end":"2026-09-15T02:19:49.055314Z","steps":["trace[1823784997] 'agreement among raft nodes before linearized reading' (duration: 126.08974ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:19:49.055424Z","caller":"traceutil/trace.go:171","msg":"trace[362384971] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"315.96564ms","start":"2026-09-15T02:19:48.739404Z","end":"2026-09-15T02:19:49.05537Z","steps":["trace[362384971] 'process raft request' (duration: 315.594097ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:19:49.055063Z","caller":"traceutil/trace.go:171","msg":"trace[1224198476] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:418; }","duration":"125.987259ms","start":"2026-09-15T02:19:48.929056Z","end":"2026-09-15T02:19:49.055044Z","steps":["trace[1224198476] 'read index received' (duration: 112.0969ms)","trace[1224198476] 'applied index is now lower than readState.Index' (duration: 13.888779ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:19:49.055378Z","caller":"traceutil/trace.go:171","msg":"trace[180096060] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"316.392362ms","start":"2026-09-15T02:19:48.738935Z","end":"2026-09-15T02:19:49.055327Z","steps":["trace[180096060] 'process raft request' (duration: 315.98934ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:19:49.056262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:19:48.739393Z","time spent":"316.175851ms","remote":"127.0.0.1:59904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T02:19:49.056335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:19:48.738921Z","time spent":"316.711505ms","remote":"127.0.0.1:59904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T02:19:49.056445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:19:48.737183Z","time spent":"318.010044ms","remote":"127.0.0.1:59662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:19:49.359556Z","caller":"traceutil/trace.go:171","msg":"trace[687327203] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:421; }","duration":"297.787921ms","start":"2026-09-15T02:19:49.061743Z","end":"2026-09-15T02:19:49.359531Z","steps":["trace[687327203] 'read index received' (duration: 222.915728ms)","trace[687327203] 'applied index is now lower than readState.Index' (duration: 74.870793ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:19:49.359689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.919042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-15T02:19:49.359724Z","caller":"traceutil/trace.go:171","msg":"trace[957650626] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:408; }","duration":"298.002442ms","start":"2026-09-15T02:19:49.061713Z","end":"2026-09-15T02:19:49.359715Z","steps":["trace[957650626] 'agreement among raft nodes before linearized reading' (duration: 297.905691ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:19:49.359982Z","caller":"traceutil/trace.go:171","msg":"trace[387745356] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"298.638687ms","start":"2026-09-15T02:19:49.061314Z","end":"2026-09-15T02:19:49.359953Z","steps":["trace[387745356] 'process raft request' (duration: 223.27863ms)","trace[387745356] 'compare' (duration: 74.793953ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:20:17.588192Z","caller":"traceutil/trace.go:171","msg":"trace[2018906923] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"125.891071ms","start":"2026-09-15T02:20:17.462271Z","end":"2026-09-15T02:20:17.588162Z","steps":["trace[2018906923] 'process raft request' (duration: 125.827038ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:17.588605Z","caller":"traceutil/trace.go:171","msg":"trace[61453153] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"128.045158ms","start":"2026-09-15T02:20:17.460521Z","end":"2026-09-15T02:20:17.588566Z","steps":["trace[61453153] 'process raft request' (duration: 80.078184ms)","trace[61453153] 'compare' (duration: 47.312291ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:20:22.942304Z","caller":"traceutil/trace.go:171","msg":"trace[1942617625] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"193.941046ms","start":"2026-09-15T02:20:22.748321Z","end":"2026-09-15T02:20:22.942262Z","steps":["trace[1942617625] 'process raft request' (duration: 134.79222ms)","trace[1942617625] 'compare' (duration: 58.579299ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:20:23.54146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.827407ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:20:23.5416Z","caller":"traceutil/trace.go:171","msg":"trace[68794082] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"213.00095ms","start":"2026-09-15T02:20:23.328577Z","end":"2026-09-15T02:20:23.541578Z","steps":["trace[68794082] 'process raft request' (duration: 107.719982ms)","trace[68794082] 'compare' (duration: 104.518682ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:20:23.750304Z","caller":"traceutil/trace.go:171","msg":"trace[499803700] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"102.579342ms","start":"2026-09-15T02:20:23.647696Z","end":"2026-09-15T02:20:23.750275Z","steps":["trace[499803700] 'read index received' (duration: 53.106261ms)","trace[499803700] 'applied index is now lower than readState.Index' (duration: 49.471971ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:20:23.75062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.857945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-15T02:20:23.750737Z","caller":"traceutil/trace.go:171","msg":"trace[233113088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:645; }","duration":"103.099637ms","start":"2026-09-15T02:20:23.647625Z","end":"2026-09-15T02:20:23.750725Z","steps":["trace[233113088] 'agreement among raft nodes before linearized reading' (duration: 102.759401ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:23.751098Z","caller":"traceutil/trace.go:171","msg":"trace[769903134] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"316.848171ms","start":"2026-09-15T02:20:23.434061Z","end":"2026-09-15T02:20:23.750909Z","steps":["trace[769903134] 'process raft request' (duration: 267.170741ms)","trace[769903134] 'compare' (duration: 48.60318ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:20:23.751429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:20:23.433992Z","time spent":"317.301122ms","remote":"127.0.0.1:59754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T02:20:24.16787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.090283ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:20:24.168078Z","caller":"traceutil/trace.go:171","msg":"trace[2054815786] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:646; }","duration":"241.320495ms","start":"2026-09-15T02:20:23.926728Z","end":"2026-09-15T02:20:24.168049Z","steps":["trace[2054815786] 'range keys from in-memory index tree' (duration: 241.064712ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:24.180368Z","caller":"traceutil/trace.go:171","msg":"trace[948007052] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"341.064067ms","start":"2026-09-15T02:20:23.839276Z","end":"2026-09-15T02:20:24.18034Z","steps":["trace[948007052] 'process raft request' (duration: 340.89749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:20:24.180657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:20:23.839256Z","time spent":"341.277747ms","remote":"127.0.0.1:60016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T02:20:24.380371Z","caller":"traceutil/trace.go:171","msg":"trace[199042758] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"187.138912ms","start":"2026-09-15T02:20:24.193187Z","end":"2026-09-15T02:20:24.380326Z","steps":["trace[199042758] 'read index received' (duration: 122.954968ms)","trace[199042758] 'applied index is now lower than readState.Index' (duration: 64.181824ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:20:24.38055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.33825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:20:24.380645Z","caller":"traceutil/trace.go:171","msg":"trace[723531421] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:647; }","duration":"187.511079ms","start":"2026-09-15T02:20:24.193115Z","end":"2026-09-15T02:20:24.380626Z","steps":["trace[723531421] 'agreement among raft nodes before linearized reading' (duration: 187.32644ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:20:24.380909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.986829ms","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-15T02:20:24.38109Z","caller":"traceutil/trace.go:171","msg":"trace[1711197662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:647; }","duration":"149.194939ms","start":"2026-09-15T02:20:24.231809Z","end":"2026-09-15T02:20:24.381004Z","steps":["trace[1711197662] 'agreement among raft nodes before linearized reading' (duration: 148.813461ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:20:25.591832Z","caller":"traceutil/trace.go:171","msg":"trace[440529005] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"104.493269ms","start":"2026-09-15T02:20:25.48731Z","end":"2026-09-15T02:20:25.591804Z","steps":["trace[440529005] 'process raft request' (duration: 101.338385ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:20:42.279947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.896162ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:20:42.280221Z","caller":"traceutil/trace.go:171","msg":"trace[1214500330] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"291.192325ms","start":"2026-09-15T02:20:41.988997Z","end":"2026-09-15T02:20:42.280189Z","steps":["trace[1214500330] 'process raft request' (duration: 142.958891ms)","trace[1214500330] 'compare' (duration: 147.779487ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:21:45.047546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.930645ms","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-15T02:21:45.047778Z","caller":"traceutil/trace.go:171","msg":"trace[617731869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1512; }","duration":"176.18017ms","start":"2026-09-15T02:21:44.871515Z","end":"2026-09-15T02:21:45.047696Z","steps":["trace[617731869] 'range keys from in-memory index tree' (duration: 175.662519ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:22:11.632822Z","caller":"traceutil/trace.go:171","msg":"trace[980079505] linearizableReadLoop","detail":"{readStateIndex:2009; appliedIndex:2008; }","duration":"142.79061ms","start":"2026-09-15T02:22:11.490001Z","end":"2026-09-15T02:22:11.632792Z","steps":["trace[980079505] 'read index received' (duration: 142.549225ms)","trace[980079505] 'applied index is now lower than readState.Index' (duration: 240.035µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:22:11.632911Z","caller":"traceutil/trace.go:171","msg":"trace[225659242] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"401.223846ms","start":"2026-09-15T02:22:11.231643Z","end":"2026-09-15T02:22:11.632867Z","steps":["trace[225659242] 'process raft request' (duration: 400.973862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:22:11.633145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.121267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-456f2387-ab16-46ad-a9cd-2319a49af9e0\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-15T02:22:11.633242Z","caller":"traceutil/trace.go:171","msg":"trace[91638851] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-456f2387-ab16-46ad-a9cd-2319a49af9e0; range_end:; response_count:1; response_revision:1932; }","duration":"143.271979ms","start":"2026-09-15T02:22:11.489947Z","end":"2026-09-15T02:22:11.633219Z","steps":["trace[91638851] 'agreement among raft nodes before linearized reading' (duration: 143.014404ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:22:11.633305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:22:11.231629Z","time spent":"401.358759ms","remote":"127.0.0.1:59904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:22:20.212188Z","caller":"traceutil/trace.go:171","msg":"trace[237629749] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"120.16086ms","start":"2026-09-15T02:22:20.091989Z","end":"2026-09-15T02:22:20.21215Z","steps":["trace[237629749] 'process raft request' (duration: 117.826189ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:22:26.315188Z","caller":"traceutil/trace.go:171","msg":"trace[744061132] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"138.60059ms","start":"2026-09-15T02:22:26.176535Z","end":"2026-09-15T02:22:26.315135Z","steps":["trace[744061132] 'process raft request' (duration: 138.408196ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:22:26.319085Z","caller":"traceutil/trace.go:171","msg":"trace[307648185] transaction","detail":"{read_only:false; response_revision:2057; number_of_response:1; }","duration":"140.782207ms","start":"2026-09-15T02:22:26.178276Z","end":"2026-09-15T02:22:26.319058Z","steps":["trace[307648185] 'process raft request' (duration: 140.587204ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:22:26.642185Z","caller":"traceutil/trace.go:171","msg":"trace[722192739] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"111.39496ms","start":"2026-09-15T02:22:26.53072Z","end":"2026-09-15T02:22:26.642115Z","steps":["trace[722192739] 'process raft request' (duration: 111.191307ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:22:37.91124Z","caller":"traceutil/trace.go:171","msg":"trace[1831275026] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"114.560574ms","start":"2026-09-15T02:22:37.796615Z","end":"2026-09-15T02:22:37.911176Z","steps":["trace[1831275026] 'process raft request' (duration: 114.36271ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:22:46.150449Z","caller":"traceutil/trace.go:171","msg":"trace[70615394] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"183.935486ms","start":"2026-09-15T02:22:45.96646Z","end":"2026-09-15T02:22:46.150395Z","steps":["trace[70615394] 'process raft request' (duration: 183.611271ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:22:46.758559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.673464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:22:46.758822Z","caller":"traceutil/trace.go:171","msg":"trace[207566560] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"288.611297ms","start":"2026-09-15T02:22:46.470172Z","end":"2026-09-15T02:22:46.758784Z","steps":["trace[207566560] 'process raft request' (duration: 32.594438ms)","trace[207566560] 'compare' (duration: 255.537582ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:22:47.09815Z","caller":"traceutil/trace.go:171","msg":"trace[24012827] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"166.691064ms","start":"2026-09-15T02:22:46.931403Z","end":"2026-09-15T02:22:47.098094Z","steps":["trace[24012827] 'process raft request' (duration: 166.468651ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:22:47.440487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.35643ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:22:47.440725Z","caller":"traceutil/trace.go:171","msg":"trace[1067797007] linearizableReadLoop","detail":"{readStateIndex:2273; appliedIndex:2272; }","duration":"313.023538ms","start":"2026-09-15T02:22:47.127643Z","end":"2026-09-15T02:22:47.440667Z","steps":["trace[1067797007] 'read index received' (duration: 152.049088ms)","trace[1067797007] 'applied index is now lower than readState.Index' (duration: 160.97288ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:22:47.440769Z","caller":"traceutil/trace.go:171","msg":"trace[1180990216] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"331.282477ms","start":"2026-09-15T02:22:47.109431Z","end":"2026-09-15T02:22:47.440714Z","steps":["trace[1180990216] 'process raft request' (duration: 170.373378ms)","trace[1180990216] 'compare' (duration: 159.71235ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:22:47.440848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.192921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:22:47.441015Z","caller":"traceutil/trace.go:171","msg":"trace[853285329] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2188; }","duration":"313.383263ms","start":"2026-09-15T02:22:47.127617Z","end":"2026-09-15T02:22:47.441Z","steps":["trace[853285329] 'agreement among raft nodes before linearized reading' (duration: 313.16054ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:22:47.441056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:22:47.127601Z","time spent":"313.443065ms","remote":"127.0.0.1:44376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-09-15T02:22:47.441406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:22:47.109418Z","time spent":"331.598362ms","remote":"127.0.0.1:59904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T02:22:47.441705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.040951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:22:47.441749Z","caller":"traceutil/trace.go:171","msg":"trace[725370788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2188; }","duration":"257.126093ms","start":"2026-09-15T02:22:47.18461Z","end":"2026-09-15T02:22:47.441736Z","steps":["trace[725370788] 'agreement among raft nodes before linearized reading' (duration: 257.063012ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:22:47.44217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.112556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-15T02:22:47.44221Z","caller":"traceutil/trace.go:171","msg":"trace[1162736098] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2188; }","duration":"285.200637ms","start":"2026-09-15T02:22:47.156999Z","end":"2026-09-15T02:22:47.442199Z","steps":["trace[1162736098] 'agreement among raft nodes before linearized reading' (duration: 284.636559ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:24:19.802298Z","caller":"traceutil/trace.go:171","msg":"trace[264308962] linearizableReadLoop","detail":"{readStateIndex:2832; appliedIndex:2828; }","duration":"123.683089ms","start":"2026-09-15T02:24:19.678581Z","end":"2026-09-15T02:24:19.802264Z","steps":["trace[264308962] 'read index received' (duration: 7.62378ms)","trace[264308962] 'applied index is now lower than readState.Index' (duration: 116.058189ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:24:19.802478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.867474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:24:19.802445Z","caller":"traceutil/trace.go:171","msg":"trace[220019661] transaction","detail":"{read_only:false; response_revision:2725; number_of_response:1; }","duration":"125.418941ms","start":"2026-09-15T02:24:19.676968Z","end":"2026-09-15T02:24:19.802387Z","steps":["trace[220019661] 'process raft request' (duration: 125.06147ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:24:19.802533Z","caller":"traceutil/trace.go:171","msg":"trace[531446760] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2726; }","duration":"123.959977ms","start":"2026-09-15T02:24:19.678556Z","end":"2026-09-15T02:24:19.802516Z","steps":["trace[531446760] 'agreement among raft nodes before linearized reading' (duration: 123.856443ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:24:19.802807Z","caller":"traceutil/trace.go:171","msg":"trace[1309589754] transaction","detail":"{read_only:false; response_revision:2724; number_of_response:1; }","duration":"134.096013ms","start":"2026-09-15T02:24:19.668683Z","end":"2026-09-15T02:24:19.802779Z","steps":["trace[1309589754] 'process raft request' (duration: 125.908256ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:24:19.80305Z","caller":"traceutil/trace.go:171","msg":"trace[968506431] transaction","detail":"{read_only:false; response_revision:2726; number_of_response:1; }","duration":"124.442572ms","start":"2026-09-15T02:24:19.678279Z","end":"2026-09-15T02:24:19.802722Z","steps":["trace[968506431] 'process raft request' (duration: 123.894325ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:24:31.273428Z","caller":"traceutil/trace.go:171","msg":"trace[1459512039] transaction","detail":"{read_only:false; response_revision:2834; number_of_response:1; }","duration":"226.353952ms","start":"2026-09-15T02:24:31.047031Z","end":"2026-09-15T02:24:31.273384Z","steps":["trace[1459512039] 'process raft request' (duration: 225.700743ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:25:06.6513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.943829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:25:06.651464Z","caller":"traceutil/trace.go:171","msg":"trace[1490721051] transaction","detail":"{read_only:false; response_revision:3031; number_of_response:1; }","duration":"290.637982ms","start":"2026-09-15T02:25:06.360802Z","end":"2026-09-15T02:25:06.65144Z","steps":["trace[1490721051] 'process raft request' (duration: 117.411586ms)","trace[1490721051] 'compare' (duration: 172.666382ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:29:34.975039Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2855} {"level":"info","ts":"2026-09-15T02:29:35.16606Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2855,"took":"190.039023ms","hash":3781008892,"current-db-size-bytes":49369088,"current-db-size":"49 MB","current-db-size-in-use-bytes":25989120,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-15T02:29:35.166109Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3781008892,"revision":2855,"compact-revision":-1} {"level":"info","ts":"2026-09-15T02:29:39.277854Z","caller":"traceutil/trace.go:171","msg":"trace[728858136] linearizableReadLoop","detail":"{readStateIndex:5340; appliedIndex:5339; }","duration":"100.029299ms","start":"2026-09-15T02:29:39.177803Z","end":"2026-09-15T02:29:39.277832Z","steps":["trace[728858136] 'read index received' (duration: 96.619136ms)","trace[728858136] 'applied index is now lower than readState.Index' (duration: 3.409173ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:29:39.277998Z","caller":"traceutil/trace.go:171","msg":"trace[1537630587] transaction","detail":"{read_only:false; response_revision:5138; number_of_response:1; }","duration":"110.33622ms","start":"2026-09-15T02:29:39.16765Z","end":"2026-09-15T02:29:39.277986Z","steps":["trace[1537630587] 'process raft request' (duration: 106.764394ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:39.27841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.579768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-15T02:29:39.278471Z","caller":"traceutil/trace.go:171","msg":"trace[789178594] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5139; }","duration":"100.67921ms","start":"2026-09-15T02:29:39.177776Z","end":"2026-09-15T02:29:39.278455Z","steps":["trace[789178594] 'agreement among raft nodes before linearized reading' (duration: 100.503277ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:44.930193Z","caller":"traceutil/trace.go:171","msg":"trace[365412147] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"242.992349ms","start":"2026-09-15T02:29:44.687178Z","end":"2026-09-15T02:29:44.93017Z","steps":["trace[365412147] 'process raft request' (duration: 242.955499ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:44.930277Z","caller":"traceutil/trace.go:171","msg":"trace[1665637996] linearizableReadLoop","detail":"{readStateIndex:5401; appliedIndex:5399; }","duration":"379.98582ms","start":"2026-09-15T02:29:44.550263Z","end":"2026-09-15T02:29:44.930248Z","steps":["trace[1665637996] 'read index received' (duration: 292.190874ms)","trace[1665637996] 'applied index is now lower than readState.Index' (duration: 87.790816ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:29:44.93032Z","caller":"traceutil/trace.go:171","msg":"trace[55036727] transaction","detail":"{read_only:false; response_revision:5197; number_of_response:1; }","duration":"386.336658ms","start":"2026-09-15T02:29:44.543949Z","end":"2026-09-15T02:29:44.930286Z","steps":["trace[55036727] 'process raft request' (duration: 386.081394ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:44.930508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:29:44.54393Z","time spent":"386.485041ms","remote":"127.0.0.1:59820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:29:44.930521Z","caller":"traceutil/trace.go:171","msg":"trace[1755650350] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"250.867582ms","start":"2026-09-15T02:29:44.679634Z","end":"2026-09-15T02:29:44.930502Z","steps":["trace[1755650350] 'process raft request' (duration: 250.459315ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:44.930526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.237033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b40780ac-6d3a-41ca-a71b-82ecd204b6f4\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-09-15T02:29:44.930579Z","caller":"traceutil/trace.go:171","msg":"trace[1195949438] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b40780ac-6d3a-41ca-a71b-82ecd204b6f4; range_end:; response_count:1; response_revision:5199; }","duration":"380.328834ms","start":"2026-09-15T02:29:44.550234Z","end":"2026-09-15T02:29:44.930563Z","steps":["trace[1195949438] 'agreement among raft nodes before linearized reading' (duration: 380.124831ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:44.930633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:29:44.550217Z","time spent":"380.401526ms","remote":"127.0.0.1:59790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1472,"request content":"key:\"/registry/persistentvolumes/pvc-b40780ac-6d3a-41ca-a71b-82ecd204b6f4\" "} {"level":"info","ts":"2026-09-15T02:29:44.9304Z","caller":"traceutil/trace.go:171","msg":"trace[2037734363] transaction","detail":"{read_only:false; response_revision:5196; number_of_response:1; }","duration":"393.916086ms","start":"2026-09-15T02:29:44.536461Z","end":"2026-09-15T02:29:44.930377Z","steps":["trace[2037734363] 'process raft request' (duration: 305.973788ms)","trace[2037734363] 'compare' (duration: 87.44357ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:29:44.931147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:29:44.536442Z","time spent":"394.656758ms","remote":"127.0.0.1:59810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":991,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:29:45.021398Z","caller":"traceutil/trace.go:171","msg":"trace[808286545] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"158.038087ms","start":"2026-09-15T02:29:44.863324Z","end":"2026-09-15T02:29:45.021362Z","steps":["trace[808286545] 'process raft request' (duration: 157.824424ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:45.02147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.258813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-15T02:29:45.021544Z","caller":"traceutil/trace.go:171","msg":"trace[1799499711] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5200; }","duration":"387.384614ms","start":"2026-09-15T02:29:44.634141Z","end":"2026-09-15T02:29:45.021526Z","steps":["trace[1799499711] 'agreement among raft nodes before linearized reading' (duration: 387.171581ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:45.021586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:29:44.634118Z","time spent":"387.460576ms","remote":"127.0.0.1:59904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-15T02:29:45.047364Z","caller":"traceutil/trace.go:171","msg":"trace[937532793] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"109.573133ms","start":"2026-09-15T02:29:44.937768Z","end":"2026-09-15T02:29:45.047341Z","steps":["trace[937532793] 'process raft request' (duration: 109.528473ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:45.047475Z","caller":"traceutil/trace.go:171","msg":"trace[1912061099] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"109.93706ms","start":"2026-09-15T02:29:44.937487Z","end":"2026-09-15T02:29:45.047424Z","steps":["trace[1912061099] 'process raft request' (duration: 109.652845ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:45.047902Z","caller":"traceutil/trace.go:171","msg":"trace[676658686] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"110.234794ms","start":"2026-09-15T02:29:44.937654Z","end":"2026-09-15T02:29:45.047888Z","steps":["trace[676658686] 'process raft request' (duration: 109.542983ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:45.048246Z","caller":"traceutil/trace.go:171","msg":"trace[1787516093] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"110.819043ms","start":"2026-09-15T02:29:44.937416Z","end":"2026-09-15T02:29:45.048235Z","steps":["trace[1787516093] 'process raft request' (duration: 109.533003ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:45.448168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.713187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-15T02:29:45.448286Z","caller":"traceutil/trace.go:171","msg":"trace[259616515] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5207; }","duration":"138.863378ms","start":"2026-09-15T02:29:45.309379Z","end":"2026-09-15T02:29:45.448242Z","steps":["trace[259616515] 'range keys from in-memory index tree' (duration: 138.516963ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:45.640309Z","caller":"traceutil/trace.go:171","msg":"trace[1399186925] transaction","detail":"{read_only:false; response_revision:5211; number_of_response:1; }","duration":"108.804261ms","start":"2026-09-15T02:29:45.531479Z","end":"2026-09-15T02:29:45.640283Z","steps":["trace[1399186925] 'process raft request' (duration: 98.957898ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:45.646842Z","caller":"traceutil/trace.go:171","msg":"trace[1176093223] linearizableReadLoop","detail":"{readStateIndex:5418; appliedIndex:5414; }","duration":"102.435132ms","start":"2026-09-15T02:29:45.54437Z","end":"2026-09-15T02:29:45.646806Z","steps":["trace[1176093223] 'read index received' (duration: 86.080668ms)","trace[1176093223] 'applied index is now lower than readState.Index' (duration: 16.353134ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:29:45.64699Z","caller":"traceutil/trace.go:171","msg":"trace[253047379] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"113.681777ms","start":"2026-09-15T02:29:45.533278Z","end":"2026-09-15T02:29:45.64696Z","steps":["trace[253047379] 'process raft request' (duration: 113.355362ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:45.647133Z","caller":"traceutil/trace.go:171","msg":"trace[1740411143] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"114.386868ms","start":"2026-09-15T02:29:45.532732Z","end":"2026-09-15T02:29:45.647119Z","steps":["trace[1740411143] 'process raft request' (duration: 113.810649ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:45.647183Z","caller":"traceutil/trace.go:171","msg":"trace[1088746881] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"108.696639ms","start":"2026-09-15T02:29:45.538479Z","end":"2026-09-15T02:29:45.647175Z","steps":["trace[1088746881] 'process raft request' (duration: 108.266232ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:45.647374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.976041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-15T02:29:45.647788Z","caller":"traceutil/trace.go:171","msg":"trace[693252655] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5214; }","duration":"103.429307ms","start":"2026-09-15T02:29:45.544336Z","end":"2026-09-15T02:29:45.647765Z","steps":["trace[693252655] 'agreement among raft nodes before linearized reading' (duration: 102.853628ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:48.647749Z","caller":"traceutil/trace.go:171","msg":"trace[949421624] linearizableReadLoop","detail":"{readStateIndex:5480; appliedIndex:5479; }","duration":"164.193117ms","start":"2026-09-15T02:29:48.483535Z","end":"2026-09-15T02:29:48.647728Z","steps":["trace[949421624] 'read index received' (duration: 164.068045ms)","trace[949421624] 'applied index is now lower than readState.Index' (duration: 124.042µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:29:48.64784Z","caller":"traceutil/trace.go:171","msg":"trace[284225429] transaction","detail":"{read_only:false; response_revision:5276; number_of_response:1; }","duration":"168.308461ms","start":"2026-09-15T02:29:48.479473Z","end":"2026-09-15T02:29:48.647781Z","steps":["trace[284225429] 'process raft request' (duration: 168.072648ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:48.647955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.3963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-09-15T02:29:48.64799Z","caller":"traceutil/trace.go:171","msg":"trace[531620126] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:5276; }","duration":"164.478651ms","start":"2026-09-15T02:29:48.4835Z","end":"2026-09-15T02:29:48.647978Z","steps":["trace[531620126] 'agreement among raft nodes before linearized reading' (duration: 164.350309ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:48.652901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.661743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T02:29:48.652988Z","caller":"traceutil/trace.go:171","msg":"trace[562480162] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:5277; }","duration":"151.803795ms","start":"2026-09-15T02:29:48.501165Z","end":"2026-09-15T02:29:48.652968Z","steps":["trace[562480162] 'agreement among raft nodes before linearized reading' (duration: 151.611842ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:48.653483Z","caller":"traceutil/trace.go:171","msg":"trace[384381210] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"146.619435ms","start":"2026-09-15T02:29:48.506847Z","end":"2026-09-15T02:29:48.653466Z","steps":["trace[384381210] 'process raft request' (duration: 145.811092ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:48.653754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.626936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61470"} {"level":"info","ts":"2026-09-15T02:29:48.653832Z","caller":"traceutil/trace.go:171","msg":"trace[1562454969] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5277; }","duration":"128.731347ms","start":"2026-09-15T02:29:48.525088Z","end":"2026-09-15T02:29:48.653819Z","steps":["trace[1562454969] 'agreement among raft nodes before linearized reading' (duration: 128.526944ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:49.645668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.643815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1cc38c53-eb84-42e3-a719-e553c4d967fb\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-15T02:29:49.645753Z","caller":"traceutil/trace.go:171","msg":"trace[1201055560] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1cc38c53-eb84-42e3-a719-e553c4d967fb; range_end:; response_count:1; response_revision:5309; }","duration":"139.772967ms","start":"2026-09-15T02:29:49.505955Z","end":"2026-09-15T02:29:49.645728Z","steps":["trace[1201055560] 'range keys from in-memory index tree' (duration: 139.444602ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:49.645747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.97095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-15T02:29:49.645862Z","caller":"traceutil/trace.go:171","msg":"trace[27275838] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5309; }","duration":"169.134603ms","start":"2026-09-15T02:29:49.476706Z","end":"2026-09-15T02:29:49.645841Z","steps":["trace[27275838] 'range keys from in-memory index tree' (duration: 168.778087ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:51.785246Z","caller":"traceutil/trace.go:171","msg":"trace[1165734408] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"151.712379ms","start":"2026-09-15T02:29:51.633489Z","end":"2026-09-15T02:29:51.785201Z","steps":["trace[1165734408] 'process raft request' (duration: 136.504094ms)","trace[1165734408] 'compare' (duration: 14.90339ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:30:01.226711Z","caller":"traceutil/trace.go:171","msg":"trace[1411353369] transaction","detail":"{read_only:false; response_revision:5466; number_of_response:1; }","duration":"103.844679ms","start":"2026-09-15T02:30:01.12283Z","end":"2026-09-15T02:30:01.226675Z","steps":["trace[1411353369] 'process raft request' (duration: 103.572875ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:28.280272Z","caller":"traceutil/trace.go:171","msg":"trace[659307783] transaction","detail":"{read_only:false; response_revision:6475; number_of_response:1; }","duration":"128.466473ms","start":"2026-09-15T02:32:28.151779Z","end":"2026-09-15T02:32:28.280245Z","steps":["trace[659307783] 'process raft request' (duration: 128.316141ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:28.299407Z","caller":"traceutil/trace.go:171","msg":"trace[1818580906] linearizableReadLoop","detail":"{readStateIndex:6719; appliedIndex:6717; }","duration":"115.392261ms","start":"2026-09-15T02:32:28.183984Z","end":"2026-09-15T02:32:28.299376Z","steps":["trace[1818580906] 'read index received' (duration: 96.20154ms)","trace[1818580906] 'applied index is now lower than readState.Index' (duration: 19.188831ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:32:28.299767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.751667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:32:28.29985Z","caller":"traceutil/trace.go:171","msg":"trace[1908302389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6476; }","duration":"115.91285ms","start":"2026-09-15T02:32:28.183887Z","end":"2026-09-15T02:32:28.2998Z","steps":["trace[1908302389] 'agreement among raft nodes before linearized reading' (duration: 115.716787ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:28.300107Z","caller":"traceutil/trace.go:171","msg":"trace[2142249419] transaction","detail":"{read_only:false; response_revision:6476; number_of_response:1; }","duration":"147.006384ms","start":"2026-09-15T02:32:28.153058Z","end":"2026-09-15T02:32:28.300064Z","steps":["trace[2142249419] 'process raft request' (duration: 146.02876ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:30.271735Z","caller":"traceutil/trace.go:171","msg":"trace[1838757965] transaction","detail":"{read_only:false; response_revision:6484; number_of_response:1; }","duration":"122.415143ms","start":"2026-09-15T02:32:30.14927Z","end":"2026-09-15T02:32:30.271685Z","steps":["trace[1838757965] 'process raft request' (duration: 122.109349ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:31.970153Z","caller":"traceutil/trace.go:171","msg":"trace[1628354760] transaction","detail":"{read_only:false; response_revision:6491; number_of_response:1; }","duration":"174.499106ms","start":"2026-09-15T02:32:31.795613Z","end":"2026-09-15T02:32:31.970112Z","steps":["trace[1628354760] 'process raft request' (duration: 155.582689ms)","trace[1628354760] 'compare' (duration: 18.297038ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:32:36.085808Z","caller":"traceutil/trace.go:171","msg":"trace[852295364] transaction","detail":"{read_only:false; response_revision:6512; number_of_response:1; }","duration":"104.199575ms","start":"2026-09-15T02:32:35.98157Z","end":"2026-09-15T02:32:36.085769Z","steps":["trace[852295364] 'process raft request' (duration: 103.400573ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:36.246747Z","caller":"traceutil/trace.go:171","msg":"trace[911067898] transaction","detail":"{read_only:false; response_revision:6518; number_of_response:1; }","duration":"146.643496ms","start":"2026-09-15T02:32:36.100069Z","end":"2026-09-15T02:32:36.246713Z","steps":["trace[911067898] 'process raft request' (duration: 146.549315ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:36.246812Z","caller":"traceutil/trace.go:171","msg":"trace[443809284] transaction","detail":"{read_only:false; response_revision:6517; number_of_response:1; }","duration":"147.006752ms","start":"2026-09-15T02:32:36.09978Z","end":"2026-09-15T02:32:36.246787Z","steps":["trace[443809284] 'process raft request' (duration: 146.686317ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:36.24707Z","caller":"traceutil/trace.go:171","msg":"trace[37181336] transaction","detail":"{read_only:false; response_revision:6515; number_of_response:1; }","duration":"151.370785ms","start":"2026-09-15T02:32:36.095682Z","end":"2026-09-15T02:32:36.247052Z","steps":["trace[37181336] 'process raft request' (duration: 148.618905ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:36.247301Z","caller":"traceutil/trace.go:171","msg":"trace[1509607514] transaction","detail":"{read_only:false; response_revision:6516; number_of_response:1; }","duration":"149.915335ms","start":"2026-09-15T02:32:36.097373Z","end":"2026-09-15T02:32:36.247288Z","steps":["trace[1509607514] 'process raft request' (duration: 149.007661ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:36.464992Z","caller":"traceutil/trace.go:171","msg":"trace[1679969044] transaction","detail":"{read_only:false; response_revision:6519; number_of_response:1; }","duration":"195.318298ms","start":"2026-09-15T02:32:36.269622Z","end":"2026-09-15T02:32:36.464941Z","steps":["trace[1679969044] 'process raft request' (duration: 171.375768ms)","trace[1679969044] 'compare' (duration: 23.776128ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:32:38.264805Z","caller":"traceutil/trace.go:171","msg":"trace[1259878899] transaction","detail":"{read_only:false; response_revision:6529; number_of_response:1; }","duration":"109.217087ms","start":"2026-09-15T02:32:38.155541Z","end":"2026-09-15T02:32:38.264758Z","steps":["trace[1259878899] 'process raft request' (duration: 108.934433ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:40.086337Z","caller":"traceutil/trace.go:171","msg":"trace[2092396810] transaction","detail":"{read_only:false; response_revision:6537; number_of_response:1; }","duration":"233.357994ms","start":"2026-09-15T02:32:39.852951Z","end":"2026-09-15T02:32:40.086309Z","steps":["trace[2092396810] 'process raft request' (duration: 233.170471ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:40.110356Z","caller":"traceutil/trace.go:171","msg":"trace[107948856] transaction","detail":"{read_only:false; response_revision:6539; number_of_response:1; }","duration":"119.338715ms","start":"2026-09-15T02:32:39.990992Z","end":"2026-09-15T02:32:40.110331Z","steps":["trace[107948856] 'process raft request' (duration: 119.288474ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:40.110461Z","caller":"traceutil/trace.go:171","msg":"trace[21449459] transaction","detail":"{read_only:false; response_revision:6538; number_of_response:1; }","duration":"225.926395ms","start":"2026-09-15T02:32:39.884473Z","end":"2026-09-15T02:32:40.110399Z","steps":["trace[21449459] 'process raft request' (duration: 225.685121ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:40.386036Z","caller":"traceutil/trace.go:171","msg":"trace[1673447263] transaction","detail":"{read_only:false; response_revision:6541; number_of_response:1; }","duration":"113.857075ms","start":"2026-09-15T02:32:40.27215Z","end":"2026-09-15T02:32:40.386007Z","steps":["trace[1673447263] 'process raft request' (duration: 113.713483ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:40.830191Z","caller":"traceutil/trace.go:171","msg":"trace[1435424055] transaction","detail":"{read_only:false; response_revision:6546; number_of_response:1; }","duration":"111.800545ms","start":"2026-09-15T02:32:40.718365Z","end":"2026-09-15T02:32:40.830166Z","steps":["trace[1435424055] 'process raft request' (duration: 111.626623ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:44.484202Z","caller":"traceutil/trace.go:171","msg":"trace[1934892760] transaction","detail":"{read_only:false; response_revision:6564; number_of_response:1; }","duration":"299.602229ms","start":"2026-09-15T02:32:44.184574Z","end":"2026-09-15T02:32:44.484176Z","steps":["trace[1934892760] 'process raft request' (duration: 299.266914ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:44.484088Z","caller":"traceutil/trace.go:171","msg":"trace[150687828] linearizableReadLoop","detail":"{readStateIndex:6811; appliedIndex:6810; }","duration":"365.34874ms","start":"2026-09-15T02:32:44.118707Z","end":"2026-09-15T02:32:44.484056Z","steps":["trace[150687828] 'read index received' (duration: 266.068919ms)","trace[150687828] 'applied index is now lower than readState.Index' (duration: 99.277171ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:32:44.571928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.178254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:32:44.572059Z","caller":"traceutil/trace.go:171","msg":"trace[2125566918] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:6564; }","duration":"453.358177ms","start":"2026-09-15T02:32:44.118659Z","end":"2026-09-15T02:32:44.572017Z","steps":["trace[2125566918] 'agreement among raft nodes before linearized reading' (duration: 365.539103ms)","trace[2125566918] 'count revisions from in-memory index tree' (duration: 87.61103ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:32:44.572127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:32:44.11864Z","time spent":"453.468428ms","remote":"127.0.0.1:50226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true "} {"level":"info","ts":"2026-09-15T02:32:44.572138Z","caller":"traceutil/trace.go:171","msg":"trace[1255404193] transaction","detail":"{read_only:false; response_revision:6566; number_of_response:1; }","duration":"122.708533ms","start":"2026-09-15T02:32:44.4494Z","end":"2026-09-15T02:32:44.572108Z","steps":["trace[1255404193] 'process raft request' (duration: 122.586871ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:32:44.572146Z","caller":"traceutil/trace.go:171","msg":"trace[187590388] transaction","detail":"{read_only:false; response_revision:6565; number_of_response:1; }","duration":"371.701473ms","start":"2026-09-15T02:32:44.200398Z","end":"2026-09-15T02:32:44.5721Z","steps":["trace[187590388] 'process raft request' (duration: 283.763018ms)","trace[187590388] 'compare' (duration: 87.671721ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:32:44.572362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:32:44.200381Z","time spent":"371.851245ms","remote":"127.0.0.1:59904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T02:32:44.572593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.165288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:32:44.57265Z","caller":"traceutil/trace.go:171","msg":"trace[1859926394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6566; }","duration":"389.27083ms","start":"2026-09-15T02:32:44.183366Z","end":"2026-09-15T02:32:44.572637Z","steps":["trace[1859926394] 'agreement among raft nodes before linearized reading' (duration: 389.118518ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:32:44.572686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:32:44.183347Z","time spent":"389.32681ms","remote":"127.0.0.1:59618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-15T02:32:45.36933Z","caller":"traceutil/trace.go:171","msg":"trace[251407954] transaction","detail":"{read_only:false; response_revision:6572; number_of_response:1; }","duration":"113.414306ms","start":"2026-09-15T02:32:45.255866Z","end":"2026-09-15T02:32:45.36928Z","steps":["trace[251407954] 'process raft request' (duration: 88.603923ms)","trace[251407954] 'compare' (duration: 24.470518ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:34:34.982537Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5038} {"level":"info","ts":"2026-09-15T02:34:35.06845Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5038,"took":"84.089987ms","hash":3344543725,"current-db-size-bytes":49369088,"current-db-size":"49 MB","current-db-size-in-use-bytes":19763200,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-09-15T02:34:35.068539Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3344543725,"revision":5038,"compact-revision":2855}