{"level":"warn","ts":"2026-04-06T21:04:27.774519Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-06T21:04:27.774603Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-06T21:04:27.774666Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-06T21:04:27.774678Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-04-06T21:04:27.774699Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-06T21:04:27.775466Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-04-06T21:04:27.775565Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-06T21:04:27.779489Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.685706ms"} {"level":"info","ts":"2026-04-06T21:04:27.786993Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-04-06T21:04:27.787114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-04-06T21:04:27.787152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-04-06T21:04:27.787178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-06T21:04:27.787198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-04-06T21:04:27.787254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-04-06T21:04:27.794539Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-06T21:04:27.795975Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-06T21:04:27.797493Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-06T21:04:27.799331Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-06T21:04:27.799769Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-06T21:04:27.79982Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-06T21:04:27.799934Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-06T21:04:27.799976Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-06T21:04:27.80111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-04-06T21:04:27.80137Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-04-06T21:04:27.804153Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-06T21:04:27.804323Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-04-06T21:04:27.804448Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-06T21:04:27.80446Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-04-06T21:04:27.804514Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-06T21:04:28.188931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-04-06T21:04:28.189093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-06T21:04:28.189148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-04-06T21:04:28.189193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-04-06T21:04:28.189245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-04-06T21:04:28.189288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-04-06T21:04:28.189334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-04-06T21:04:28.19017Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-04-06T21:04:28.190174Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:04:28.190256Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T21:04:28.190159Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-06T21:04:28.190557Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-06T21:04:28.190616Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-06T21:04:28.19097Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:04:28.191122Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:04:28.191166Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-06T21:04:28.194246Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"info","ts":"2026-04-06T21:04:28.194245Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-06T21:04:38.170302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.30027ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:04:38.170506Z","caller":"traceutil/trace.go:171","msg":"trace[852138104] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"265.430048ms","start":"2026-04-06T21:04:37.905059Z","end":"2026-04-06T21:04:38.170489Z","steps":["trace[852138104] 'process raft request' (duration: 265.377597ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:04:38.1705Z","caller":"traceutil/trace.go:171","msg":"trace[114855256] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"286.119394ms","start":"2026-04-06T21:04:37.884343Z","end":"2026-04-06T21:04:38.170462Z","steps":["trace[114855256] 'process raft request' (duration: 144.132677ms)","trace[114855256] 'compare' (duration: 141.164537ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:04:38.170513Z","caller":"traceutil/trace.go:171","msg":"trace[1838898183] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:360; }","duration":"266.340119ms","start":"2026-04-06T21:04:37.904147Z","end":"2026-04-06T21:04:38.170487Z","steps":["trace[1838898183] 'read index received' (duration: 124.421723ms)","trace[1838898183] 'applied index is now lower than readState.Index' (duration: 141.915396ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:04:38.170683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.512443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-06T21:04:38.171029Z","caller":"traceutil/trace.go:171","msg":"trace[431916277] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:348; }","duration":"266.876741ms","start":"2026-04-06T21:04:37.904116Z","end":"2026-04-06T21:04:38.170993Z","steps":["trace[431916277] 'agreement among raft nodes before linearized reading' (duration: 266.460962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:04:38.17138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.722112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-06T21:04:38.171474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.392394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-06T21:04:38.171555Z","caller":"traceutil/trace.go:171","msg":"trace[1545764343] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:348; }","duration":"167.492266ms","start":"2026-04-06T21:04:38.004038Z","end":"2026-04-06T21:04:38.171531Z","steps":["trace[1545764343] 'agreement among raft nodes before linearized reading' (duration: 167.296511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:04:38.171693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.312497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-06T21:04:38.17174Z","caller":"traceutil/trace.go:171","msg":"trace[1932795824] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:348; }","duration":"117.388078ms","start":"2026-04-06T21:04:38.054339Z","end":"2026-04-06T21:04:38.171727Z","steps":["trace[1932795824] 'agreement among raft nodes before linearized reading' (duration: 117.297146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:04:38.171717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.373292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-06T21:04:38.171815Z","caller":"traceutil/trace.go:171","msg":"trace[536348581] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:348; }","duration":"218.536046ms","start":"2026-04-06T21:04:37.953257Z","end":"2026-04-06T21:04:38.171793Z","steps":["trace[536348581] 'agreement among raft nodes before linearized reading' (duration: 218.248779ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:04:38.171491Z","caller":"traceutil/trace.go:171","msg":"trace[2029135451] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:348; }","duration":"233.883485ms","start":"2026-04-06T21:04:37.937583Z","end":"2026-04-06T21:04:38.171466Z","steps":["trace[2029135451] 'agreement among raft nodes before linearized reading' (duration: 233.65174ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:04:38.505112Z","caller":"traceutil/trace.go:171","msg":"trace[2076453665] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"328.334295ms","start":"2026-04-06T21:04:38.176756Z","end":"2026-04-06T21:04:38.50509Z","steps":["trace[2076453665] 'process raft request' (duration: 327.994047ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:04:38.505316Z","caller":"traceutil/trace.go:171","msg":"trace[1501753761] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"325.907299ms","start":"2026-04-06T21:04:38.179385Z","end":"2026-04-06T21:04:38.505292Z","steps":["trace[1501753761] 'process raft request' (duration: 325.55078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:04:38.505407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:04:38.179368Z","time spent":"325.99854ms","remote":"127.0.0.1:38720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-06T21:04:38.505631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:04:38.176734Z","time spent":"328.52984ms","remote":"127.0.0.1:38512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:04:38.505616Z","caller":"traceutil/trace.go:171","msg":"trace[717773782] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:362; }","duration":"301.392202ms","start":"2026-04-06T21:04:38.204201Z","end":"2026-04-06T21:04:38.505593Z","steps":["trace[717773782] 'read index received' (duration: 18.73495ms)","trace[717773782] 'applied index is now lower than readState.Index' (duration: 282.656472ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:04:38.505694Z","caller":"traceutil/trace.go:171","msg":"trace[1274551017] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"324.754022ms","start":"2026-04-06T21:04:38.180881Z","end":"2026-04-06T21:04:38.505635Z","steps":["trace[1274551017] 'process raft request' (duration: 324.557767ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:04:38.505777Z","caller":"traceutil/trace.go:171","msg":"trace[131433272] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"320.834749ms","start":"2026-04-06T21:04:38.184927Z","end":"2026-04-06T21:04:38.505762Z","steps":["trace[131433272] 'process raft request' (duration: 320.591743ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:04:38.505742Z","caller":"traceutil/trace.go:171","msg":"trace[1673433617] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"320.795929ms","start":"2026-04-06T21:04:38.184878Z","end":"2026-04-06T21:04:38.505674Z","steps":["trace[1673433617] 'process raft request' (duration: 320.594224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:04:38.505849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.623337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-06T21:04:38.505855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:04:38.180872Z","time spent":"324.909555ms","remote":"127.0.0.1:38330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-06T21:04:38.505874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:04:38.184921Z","time spent":"320.908991ms","remote":"127.0.0.1:38602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:04:38.505898Z","caller":"traceutil/trace.go:171","msg":"trace[672946736] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:358; }","duration":"301.712849ms","start":"2026-04-06T21:04:38.204176Z","end":"2026-04-06T21:04:38.505889Z","steps":["trace[672946736] 'agreement among raft nodes before linearized reading' (duration: 301.490574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:04:38.505935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:04:38.204164Z","time spent":"301.7619ms","remote":"127.0.0.1:38440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"info","ts":"2026-04-06T21:04:38.505918Z","caller":"traceutil/trace.go:171","msg":"trace[134056885] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"320.856339ms","start":"2026-04-06T21:04:38.185018Z","end":"2026-04-06T21:04:38.505874Z","steps":["trace[134056885] 'process raft request' (duration: 320.537092ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:04:38.506051Z","caller":"traceutil/trace.go:171","msg":"trace[682402404] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"325.718404ms","start":"2026-04-06T21:04:38.18028Z","end":"2026-04-06T21:04:38.505998Z","steps":["trace[682402404] 'process raft request' (duration: 325.066959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:04:38.506119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:04:38.185012Z","time spent":"320.978402ms","remote":"127.0.0.1:38602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-06T21:04:38.506143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:04:38.180172Z","time spent":"325.926518ms","remote":"127.0.0.1:38344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:04:38.506133Z","caller":"traceutil/trace.go:171","msg":"trace[283087280] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"325.54771ms","start":"2026-04-06T21:04:38.180537Z","end":"2026-04-06T21:04:38.506083Z","steps":["trace[283087280] 'process raft request' (duration: 324.866164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:04:38.506242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:04:38.180528Z","time spent":"325.670803ms","remote":"127.0.0.1:38344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-06T21:04:38.506276Z","caller":"traceutil/trace.go:171","msg":"trace[241670042] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"326.39581ms","start":"2026-04-06T21:04:38.179812Z","end":"2026-04-06T21:04:38.506208Z","steps":["trace[241670042] 'process raft request' (duration: 325.413707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:04:38.506462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:04:38.179792Z","time spent":"326.590025ms","remote":"127.0.0.1:38526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-06T21:04:38.5065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:04:38.18487Z","time spent":"320.973022ms","remote":"127.0.0.1:38602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:04:56.629507Z","caller":"traceutil/trace.go:171","msg":"trace[26152298] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"107.2755ms","start":"2026-04-06T21:04:56.522202Z","end":"2026-04-06T21:04:56.629478Z","steps":["trace[26152298] 'process raft request' (duration: 52.755879ms)","trace[26152298] 'compare' (duration: 54.403778ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:04:56.630365Z","caller":"traceutil/trace.go:171","msg":"trace[185753463] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"103.126373ms","start":"2026-04-06T21:04:56.527214Z","end":"2026-04-06T21:04:56.630341Z","steps":["trace[185753463] 'process raft request' (duration: 102.903448ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:04:58.383963Z","caller":"traceutil/trace.go:171","msg":"trace[564970494] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"101.097225ms","start":"2026-04-06T21:04:58.28282Z","end":"2026-04-06T21:04:58.383918Z","steps":["trace[564970494] 'compare' (duration: 93.20099ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:04.489684Z","caller":"traceutil/trace.go:171","msg":"trace[1326194479] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"104.155138ms","start":"2026-04-06T21:05:04.385503Z","end":"2026-04-06T21:05:04.489658Z","steps":["trace[1326194479] 'process raft request' (duration: 104.013405ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:05:04.927197Z","caller":"traceutil/trace.go:171","msg":"trace[536201288] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"242.070739ms","start":"2026-04-06T21:05:04.68506Z","end":"2026-04-06T21:05:04.92713Z","steps":["trace[536201288] 'read index received' (duration: 237.300307ms)","trace[536201288] 'applied index is now lower than readState.Index' (duration: 4.769502ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:05:04.92724Z","caller":"traceutil/trace.go:171","msg":"trace[98058003] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"346.272578ms","start":"2026-04-06T21:05:04.580922Z","end":"2026-04-06T21:05:04.927195Z","steps":["trace[98058003] 'process raft request' (duration: 344.343232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:04.927417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.338135ms","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-04-06T21:05:04.927472Z","caller":"traceutil/trace.go:171","msg":"trace[1769242309] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:619; }","duration":"242.459128ms","start":"2026-04-06T21:05:04.685001Z","end":"2026-04-06T21:05:04.92746Z","steps":["trace[1769242309] 'agreement among raft nodes before linearized reading' (duration: 242.267083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:04.927465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:04.580885Z","time spent":"346.452262ms","remote":"127.0.0.1:38340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:05:05.406819Z","caller":"traceutil/trace.go:171","msg":"trace[97114787] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"348.323786ms","start":"2026-04-06T21:05:05.058469Z","end":"2026-04-06T21:05:05.406792Z","steps":["trace[97114787] 'read index received' (duration: 348.112941ms)","trace[97114787] 'applied index is now lower than readState.Index' (duration: 209.905µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:05:05.406886Z","caller":"traceutil/trace.go:171","msg":"trace[170800472] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"418.724779ms","start":"2026-04-06T21:05:04.988134Z","end":"2026-04-06T21:05:05.406859Z","steps":["trace[170800472] 'process raft request' (duration: 418.503364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:05.407069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:04.988104Z","time spent":"418.840122ms","remote":"127.0.0.1:38748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-06T21:05:05.407166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.698244ms","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-04-06T21:05:05.407221Z","caller":"traceutil/trace.go:171","msg":"trace[599832537] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:621; }","duration":"348.811546ms","start":"2026-04-06T21:05:05.058395Z","end":"2026-04-06T21:05:05.407206Z","steps":["trace[599832537] 'agreement among raft nodes before linearized reading' (duration: 348.54178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:05.407256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:05:05.058369Z","time spent":"348.879078ms","remote":"127.0.0.1:38512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-06T21:05:05.407332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.02334ms","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-04-06T21:05:05.40744Z","caller":"traceutil/trace.go:171","msg":"trace[1727625034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:621; }","duration":"297.201794ms","start":"2026-04-06T21:05:05.110212Z","end":"2026-04-06T21:05:05.407414Z","steps":["trace[1727625034] 'agreement among raft nodes before linearized reading' (duration: 296.953888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:21.887851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.555265ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-06T21:05:21.888339Z","caller":"traceutil/trace.go:171","msg":"trace[1602327215] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"296.643117ms","start":"2026-04-06T21:05:21.591636Z","end":"2026-04-06T21:05:21.888279Z","steps":["trace[1602327215] 'process raft request' (duration: 119.487978ms)","trace[1602327215] 'compare' (duration: 176.32529ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:05:48.223157Z","caller":"traceutil/trace.go:171","msg":"trace[370873993] linearizableReadLoop","detail":"{readStateIndex:1215; appliedIndex:1214; }","duration":"199.858423ms","start":"2026-04-06T21:05:48.023273Z","end":"2026-04-06T21:05:48.223132Z","steps":["trace[370873993] 'read index received' (duration: 199.554296ms)","trace[370873993] 'applied index is now lower than readState.Index' (duration: 303.227µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:05:48.223291Z","caller":"traceutil/trace.go:171","msg":"trace[997109085] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"208.338058ms","start":"2026-04-06T21:05:48.014908Z","end":"2026-04-06T21:05:48.223246Z","steps":["trace[997109085] 'process raft request' (duration: 208.034221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:05:48.223474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.145889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-06T21:05:48.223529Z","caller":"traceutil/trace.go:171","msg":"trace[279320150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1177; }","duration":"200.282272ms","start":"2026-04-06T21:05:48.023231Z","end":"2026-04-06T21:05:48.223514Z","steps":["trace[279320150] 'agreement among raft nodes before linearized reading' (duration: 200.013166ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:06:34.252654Z","caller":"traceutil/trace.go:171","msg":"trace[1709815880] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"319.742034ms","start":"2026-04-06T21:06:33.932876Z","end":"2026-04-06T21:06:34.252618Z","steps":["trace[1709815880] 'process raft request' (duration: 319.57643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:34.252871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:06:33.93285Z","time spent":"319.924858ms","remote":"127.0.0.1:38512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:06:34.272924Z","caller":"traceutil/trace.go:171","msg":"trace[1909457454] linearizableReadLoop","detail":"{readStateIndex:1908; appliedIndex:1906; }","duration":"157.795728ms","start":"2026-04-06T21:06:34.1151Z","end":"2026-04-06T21:06:34.272896Z","steps":["trace[1909457454] 'read index received' (duration: 137.394021ms)","trace[1909457454] 'applied index is now lower than readState.Index' (duration: 20.400667ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:06:34.272965Z","caller":"traceutil/trace.go:171","msg":"trace[1758158277] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"164.532815ms","start":"2026-04-06T21:06:34.108399Z","end":"2026-04-06T21:06:34.272932Z","steps":["trace[1758158277] 'process raft request' (duration: 164.377081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:06:34.273121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.015914ms","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-04-06T21:06:34.27317Z","caller":"traceutil/trace.go:171","msg":"trace[1611238083] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1832; }","duration":"158.107736ms","start":"2026-04-06T21:06:34.11505Z","end":"2026-04-06T21:06:34.273158Z","steps":["trace[1611238083] 'agreement among raft nodes before linearized reading' (duration: 157.949771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:07:18.688648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.199015ms","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-04-06T21:07:18.688756Z","caller":"traceutil/trace.go:171","msg":"trace[1059433808] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2130; }","duration":"107.340528ms","start":"2026-04-06T21:07:18.581395Z","end":"2026-04-06T21:07:18.688736Z","steps":["trace[1059433808] 'range keys from in-memory index tree' (duration: 107.052062ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:07:24.689625Z","caller":"traceutil/trace.go:171","msg":"trace[2061827134] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"116.898624ms","start":"2026-04-06T21:07:24.572692Z","end":"2026-04-06T21:07:24.689591Z","steps":["trace[2061827134] 'process raft request' (duration: 48.131228ms)","trace[2061827134] 'compare' (duration: 68.623433ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:07:24.866636Z","caller":"traceutil/trace.go:171","msg":"trace[140496737] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"108.585877ms","start":"2026-04-06T21:07:24.758006Z","end":"2026-04-06T21:07:24.866592Z","steps":["trace[140496737] 'process raft request' (duration: 87.662992ms)","trace[140496737] 'compare' (duration: 20.25862ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:08:47.969816Z","caller":"traceutil/trace.go:171","msg":"trace[380443718] transaction","detail":"{read_only:false; response_revision:2806; number_of_response:1; }","duration":"115.081818ms","start":"2026-04-06T21:08:47.854703Z","end":"2026-04-06T21:08:47.969785Z","steps":["trace[380443718] 'process raft request' (duration: 114.825062ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:08:48.149844Z","caller":"traceutil/trace.go:171","msg":"trace[1442376321] transaction","detail":"{read_only:false; response_revision:2808; number_of_response:1; }","duration":"123.13134ms","start":"2026-04-06T21:08:48.026679Z","end":"2026-04-06T21:08:48.14981Z","steps":["trace[1442376321] 'process raft request' (duration: 122.909584ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:30.148973Z","caller":"traceutil/trace.go:171","msg":"trace[2013891990] linearizableReadLoop","detail":"{readStateIndex:4876; appliedIndex:4875; }","duration":"114.370226ms","start":"2026-04-06T21:12:30.034578Z","end":"2026-04-06T21:12:30.148948Z","steps":["trace[2013891990] 'read index received' (duration: 114.162451ms)","trace[2013891990] 'applied index is now lower than readState.Index' (duration: 206.145µs)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:12:30.149077Z","caller":"traceutil/trace.go:171","msg":"trace[939783583] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"115.218985ms","start":"2026-04-06T21:12:30.033831Z","end":"2026-04-06T21:12:30.14905Z","steps":["trace[939783583] 'process raft request' (duration: 114.911898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:30.149361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.763645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-04-06T21:12:30.14941Z","caller":"traceutil/trace.go:171","msg":"trace[343244190] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4693; }","duration":"114.861748ms","start":"2026-04-06T21:12:30.034535Z","end":"2026-04-06T21:12:30.149397Z","steps":["trace[343244190] 'agreement among raft nodes before linearized reading' (duration: 114.53964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:30.174182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.804851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:19 size:511869"} {"level":"info","ts":"2026-04-06T21:12:30.174256Z","caller":"traceutil/trace.go:171","msg":"trace[1748162176] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:19; response_revision:4694; }","duration":"135.047528ms","start":"2026-04-06T21:12:30.039194Z","end":"2026-04-06T21:12:30.174241Z","steps":["trace[1748162176] 'agreement among raft nodes before linearized reading' (duration: 132.346283ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:33.679908Z","caller":"traceutil/trace.go:171","msg":"trace[1912724628] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"105.466805ms","start":"2026-04-06T21:12:33.5744Z","end":"2026-04-06T21:12:33.679867Z","steps":["trace[1912724628] 'process raft request' (duration: 105.291691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:47.327763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.570899ms","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-04-06T21:12:47.327916Z","caller":"traceutil/trace.go:171","msg":"trace[762960739] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5150; }","duration":"128.720953ms","start":"2026-04-06T21:12:47.19916Z","end":"2026-04-06T21:12:47.327881Z","steps":["trace[762960739] 'range keys from in-memory index tree' (duration: 128.388785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:47.327958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.766644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-06T21:12:47.328124Z","caller":"traceutil/trace.go:171","msg":"trace[833687633] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5150; }","duration":"116.02959ms","start":"2026-04-06T21:12:47.212067Z","end":"2026-04-06T21:12:47.328097Z","steps":["trace[833687633] 'range keys from in-memory index tree' (duration: 115.483867ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:47.580445Z","caller":"traceutil/trace.go:171","msg":"trace[964423056] transaction","detail":"{read_only:false; response_revision:5152; number_of_response:1; }","duration":"247.397985ms","start":"2026-04-06T21:12:47.333005Z","end":"2026-04-06T21:12:47.580403Z","steps":["trace[964423056] 'process raft request' (duration: 247.15527ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:47.58067Z","caller":"traceutil/trace.go:171","msg":"trace[1098863766] transaction","detail":"{read_only:false; response_revision:5153; number_of_response:1; }","duration":"247.375375ms","start":"2026-04-06T21:12:47.333266Z","end":"2026-04-06T21:12:47.580642Z","steps":["trace[1098863766] 'process raft request' (duration: 247.067198ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:47.580647Z","caller":"traceutil/trace.go:171","msg":"trace[1564446561] linearizableReadLoop","detail":"{readStateIndex:5351; appliedIndex:5349; }","duration":"209.383392ms","start":"2026-04-06T21:12:47.371233Z","end":"2026-04-06T21:12:47.580617Z","steps":["trace[1564446561] 'read index received' (duration: 208.940361ms)","trace[1564446561] 'applied index is now lower than readState.Index' (duration: 438.31µs)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:12:47.580805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.549668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-06T21:12:47.580871Z","caller":"traceutil/trace.go:171","msg":"trace[1161266526] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5153; }","duration":"239.634501ms","start":"2026-04-06T21:12:47.341204Z","end":"2026-04-06T21:12:47.580839Z","steps":["trace[1161266526] 'agreement among raft nodes before linearized reading' (duration: 239.479987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:47.581209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.57109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130702"} {"level":"info","ts":"2026-04-06T21:12:47.581284Z","caller":"traceutil/trace.go:171","msg":"trace[570371530] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5153; }","duration":"247.687733ms","start":"2026-04-06T21:12:47.333582Z","end":"2026-04-06T21:12:47.58127Z","steps":["trace[570371530] 'agreement among raft nodes before linearized reading' (duration: 247.415326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:47.581618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.939707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bmdx7\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-06T21:12:47.581726Z","caller":"traceutil/trace.go:171","msg":"trace[1319538165] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bmdx7; range_end:; response_count:1; response_revision:5153; }","duration":"147.043999ms","start":"2026-04-06T21:12:47.434611Z","end":"2026-04-06T21:12:47.581655Z","steps":["trace[1319538165] 'agreement among raft nodes before linearized reading' (duration: 146.915155ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:55.503858Z","caller":"traceutil/trace.go:171","msg":"trace[1034151187] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"115.019437ms","start":"2026-04-06T21:12:55.388808Z","end":"2026-04-06T21:12:55.503828Z","steps":["trace[1034151187] 'process raft request' (duration: 114.752061ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:55.511332Z","caller":"traceutil/trace.go:171","msg":"trace[1366110700] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"111.978744ms","start":"2026-04-06T21:12:55.399322Z","end":"2026-04-06T21:12:55.511301Z","steps":["trace[1366110700] 'process raft request' (duration: 111.82051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:12:57.996739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.464772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-06T21:12:57.996819Z","caller":"traceutil/trace.go:171","msg":"trace[663743843] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5343; }","duration":"132.606365ms","start":"2026-04-06T21:12:57.864195Z","end":"2026-04-06T21:12:57.996801Z","steps":["trace[663743843] 'count revisions from in-memory index tree' (duration: 132.346759ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:12:57.997141Z","caller":"traceutil/trace.go:171","msg":"trace[190287957] transaction","detail":"{read_only:false; response_revision:5344; number_of_response:1; }","duration":"108.816989ms","start":"2026-04-06T21:12:57.888296Z","end":"2026-04-06T21:12:57.997113Z","steps":["trace[190287957] 'process raft request' (duration: 93.022513ms)","trace[190287957] 'compare' (duration: 15.671152ms)"],"step_count":2} {"level":"info","ts":"2026-04-06T21:13:07.313244Z","caller":"traceutil/trace.go:171","msg":"trace[2009429390] transaction","detail":"{read_only:false; response_revision:5492; number_of_response:1; }","duration":"325.848562ms","start":"2026-04-06T21:13:06.987361Z","end":"2026-04-06T21:13:07.31321Z","steps":["trace[2009429390] 'process raft request' (duration: 228.762162ms)","trace[2009429390] 'compare' (duration: 96.932486ms)"],"step_count":2} {"level":"warn","ts":"2026-04-06T21:13:07.313451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:13:06.987335Z","time spent":"326.018686ms","remote":"127.0.0.1:43556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7439,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:14:28.222733Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3027} {"level":"info","ts":"2026-04-06T21:14:28.312622Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3027,"took":"87.948424ms","hash":142915626,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":31928320,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-06T21:14:28.312695Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":142915626,"revision":3027,"compact-revision":-1} {"level":"info","ts":"2026-04-06T21:18:54.60213Z","caller":"traceutil/trace.go:171","msg":"trace[528154804] transaction","detail":"{read_only:false; response_revision:8128; number_of_response:1; }","duration":"308.542445ms","start":"2026-04-06T21:18:54.293542Z","end":"2026-04-06T21:18:54.602085Z","steps":["trace[528154804] 'process raft request' (duration: 308.209907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-06T21:18:54.602342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-06T21:18:54.293517Z","time spent":"308.71961ms","remote":"127.0.0.1:38512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-06T21:19:28.235919Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6141} {"level":"info","ts":"2026-04-06T21:19:28.329134Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6141,"took":"90.999818ms","hash":1997990521,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":23056384,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-06T21:19:28.329226Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1997990521,"revision":6141,"compact-revision":3027} {"level":"info","ts":"2026-04-06T21:19:35.98179Z","caller":"traceutil/trace.go:171","msg":"trace[112238316] transaction","detail":"{read_only:false; response_revision:8403; number_of_response:1; }","duration":"124.004265ms","start":"2026-04-06T21:19:35.857749Z","end":"2026-04-06T21:19:35.981754Z","steps":["trace[112238316] 'process raft request' (duration: 123.234457ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:36.193177Z","caller":"traceutil/trace.go:171","msg":"trace[849046850] transaction","detail":"{read_only:false; response_revision:8405; number_of_response:1; }","duration":"206.395989ms","start":"2026-04-06T21:19:35.986754Z","end":"2026-04-06T21:19:36.19315Z","steps":["trace[849046850] 'process raft request' (duration: 204.284509ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:19:36.196056Z","caller":"traceutil/trace.go:171","msg":"trace[1027778941] transaction","detail":"{read_only:false; response_revision:8406; number_of_response:1; }","duration":"180.178664ms","start":"2026-04-06T21:19:36.015852Z","end":"2026-04-06T21:19:36.196031Z","steps":["trace[1027778941] 'process raft request' (duration: 179.687692ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:20:39.796143Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000244f.wal"} {"level":"warn","ts":"2026-04-06T21:21:05.776222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.359925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-06T21:21:05.776355Z","caller":"traceutil/trace.go:171","msg":"trace[1922456936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9269; }","duration":"205.520799ms","start":"2026-04-06T21:21:05.570808Z","end":"2026-04-06T21:21:05.776329Z","steps":["trace[1922456936] 'range keys from in-memory index tree' (duration: 205.243411ms)"],"step_count":1} {"level":"info","ts":"2026-04-06T21:21:59.679719Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2d372260bb4c37a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-06T21:21:59.68581Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-06T21:21:59.685996Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-06T21:24:28.25033Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8315} {"level":"info","ts":"2026-04-06T21:24:28.330586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8315,"took":"77.833937ms","hash":4164082135,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":24961024,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-06T21:24:28.330672Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4164082135,"revision":8315,"compact-revision":6141} {"level":"info","ts":"2026-04-06T21:29:28.256858Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10712} {"level":"info","ts":"2026-04-06T21:29:28.346368Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10712,"took":"87.079296ms","hash":3224013269,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":20422656,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-06T21:29:28.346438Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3224013269,"revision":10712,"compact-revision":8315}