{"level":"warn","ts":"2026-07-24T22:47:27.335811Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-24T22:47:27.335964Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-07-24T22:47:27.336134Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-24T22:47:27.336161Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-07-24T22:47:27.336228Z","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-07-24T22:47:27.337503Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-07-24T22:47:27.337719Z","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://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-07-24T22:47:27.342737Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.599747ms"} {"level":"info","ts":"2026-07-24T22:47:27.356571Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-07-24T22:47:27.356699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-07-24T22:47:27.356731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-07-24T22:47:27.356741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-24T22:47:27.356768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-07-24T22:47:27.356818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-07-24T22:47:27.36328Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-24T22:47:27.366197Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-24T22:47:27.369615Z","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-07-24T22:47:27.373234Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-24T22:47:27.373675Z","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-07-24T22:47:27.374245Z","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-07-24T22:47:27.373898Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-24T22:47:27.374267Z","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-07-24T22:47:27.376536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-07-24T22:47:27.376709Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-07-24T22:47:27.379366Z","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-07-24T22:47:27.37959Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-07-24T22:47:27.379651Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-07-24T22:47:27.379805Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-24T22:47:27.379887Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-24T22:47:27.557086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-07-24T22:47:27.557179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-24T22:47:27.55723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-07-24T22:47:27.557257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-07-24T22:47:27.557331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-07-24T22:47:27.557356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-07-24T22:47:27.55737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-07-24T22:47:27.558305Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-07-24T22:47:27.558355Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-24T22:47:27.558411Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-24T22:47:27.55851Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T22:47:27.558952Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-24T22:47:27.558985Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-24T22:47:27.561143Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-24T22:47:27.564465Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T22:47:27.567436Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T22:47:27.575438Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-07-24T22:47:27.575763Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T22:47:32.466566Z","caller":"traceutil/trace.go:171","msg":"trace[1220790077] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"141.509566ms","start":"2026-07-24T22:47:32.325023Z","end":"2026-07-24T22:47:32.466533Z","steps":["trace[1220790077] 'process raft request' (duration: 141.385911ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:47:32.466621Z","caller":"traceutil/trace.go:171","msg":"trace[2026828727] linearizableReadLoop","detail":"{readStateIndex:291; appliedIndex:291; }","duration":"102.518171ms","start":"2026-07-24T22:47:32.364073Z","end":"2026-07-24T22:47:32.466591Z","steps":["trace[2026828727] 'read index received' (duration: 102.505271ms)","trace[2026828727] 'applied index is now lower than readState.Index' (duration: 10.57µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T22:47:32.466833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.723999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T22:47:32.466881Z","caller":"traceutil/trace.go:171","msg":"trace[587043238] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:285; }","duration":"102.856063ms","start":"2026-07-24T22:47:32.364015Z","end":"2026-07-24T22:47:32.466872Z","steps":["trace[587043238] 'agreement among raft nodes before linearized reading' (duration: 102.713728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:47:32.713378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.761274ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-24T22:47:32.713508Z","caller":"traceutil/trace.go:171","msg":"trace[545748889] linearizableReadLoop","detail":"{readStateIndex:292; appliedIndex:291; }","duration":"246.785957ms","start":"2026-07-24T22:47:32.466706Z","end":"2026-07-24T22:47:32.713492Z","steps":["trace[545748889] 'read index received' (duration: 93.376129ms)","trace[545748889] 'applied index is now lower than readState.Index' (duration: 153.408888ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T22:47:32.713644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.172924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T22:47:32.713606Z","caller":"traceutil/trace.go:171","msg":"trace[2009991024] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"263.888707ms","start":"2026-07-24T22:47:32.44964Z","end":"2026-07-24T22:47:32.713529Z","steps":["trace[2009991024] 'process raft request' (duration: 110.444508ms)","trace[2009991024] 'compare' (duration: 152.62285ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T22:47:32.71374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.827262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-07-24T22:47:32.713845Z","caller":"traceutil/trace.go:171","msg":"trace[768244636] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:286; }","duration":"264.980788ms","start":"2026-07-24T22:47:32.448843Z","end":"2026-07-24T22:47:32.713824Z","steps":["trace[768244636] 'agreement among raft nodes before linearized reading' (duration: 264.705498ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:47:32.713678Z","caller":"traceutil/trace.go:171","msg":"trace[1480230673] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:286; }","duration":"265.249117ms","start":"2026-07-24T22:47:32.448421Z","end":"2026-07-24T22:47:32.71367Z","steps":["trace[1480230673] 'agreement among raft nodes before linearized reading' (duration: 265.153484ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:47:32.778576Z","caller":"traceutil/trace.go:171","msg":"trace[968436538] transaction","detail":"{read_only:false; number_of_response:0; response_revision:286; }","duration":"236.518603ms","start":"2026-07-24T22:47:32.542028Z","end":"2026-07-24T22:47:32.778547Z","steps":["trace[968436538] 'process raft request' (duration: 236.41823ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:47:32.784815Z","caller":"traceutil/trace.go:171","msg":"trace[1284102808] transaction","detail":"{read_only:false; number_of_response:0; response_revision:286; }","duration":"221.451067ms","start":"2026-07-24T22:47:32.563347Z","end":"2026-07-24T22:47:32.784798Z","steps":["trace[1284102808] 'process raft request' (duration: 221.365084ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:47:32.784948Z","caller":"traceutil/trace.go:171","msg":"trace[552642275] transaction","detail":"{read_only:false; number_of_response:0; response_revision:286; }","duration":"221.483979ms","start":"2026-07-24T22:47:32.563439Z","end":"2026-07-24T22:47:32.784922Z","steps":["trace[552642275] 'process raft request' (duration: 221.294992ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:47:32.785047Z","caller":"traceutil/trace.go:171","msg":"trace[420434262] transaction","detail":"{read_only:false; number_of_response:0; response_revision:286; }","duration":"221.802039ms","start":"2026-07-24T22:47:32.563198Z","end":"2026-07-24T22:47:32.785Z","steps":["trace[420434262] 'process raft request' (duration: 221.427116ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:47:32.785184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.533702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T22:47:32.785221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.298439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-07-24T22:47:32.785261Z","caller":"traceutil/trace.go:171","msg":"trace[1996054757] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:287; }","duration":"316.400483ms","start":"2026-07-24T22:47:32.468847Z","end":"2026-07-24T22:47:32.785248Z","steps":["trace[1996054757] 'agreement among raft nodes before linearized reading' (duration: 316.304949ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:47:32.785305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T22:47:32.468834Z","time spent":"316.462576ms","remote":"127.0.0.1:40758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"info","ts":"2026-07-24T22:47:32.78537Z","caller":"traceutil/trace.go:171","msg":"trace[1295512372] transaction","detail":"{read_only:false; number_of_response:0; response_revision:286; }","duration":"221.340143ms","start":"2026-07-24T22:47:32.56398Z","end":"2026-07-24T22:47:32.78532Z","steps":["trace[1295512372] 'process raft request' (duration: 220.796272ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:47:32.785459Z","caller":"traceutil/trace.go:171","msg":"trace[1343904109] transaction","detail":"{read_only:false; number_of_response:0; response_revision:286; }","duration":"221.873054ms","start":"2026-07-24T22:47:32.563577Z","end":"2026-07-24T22:47:32.78545Z","steps":["trace[1343904109] 'process raft request' (duration: 221.176017ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:47:32.785256Z","caller":"traceutil/trace.go:171","msg":"trace[1935399537] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:0; response_revision:287; }","duration":"312.636877ms","start":"2026-07-24T22:47:32.472601Z","end":"2026-07-24T22:47:32.785238Z","steps":["trace[1935399537] 'agreement among raft nodes before linearized reading' (duration: 312.47181ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:47:32.785522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T22:47:32.472594Z","time spent":"312.919817ms","remote":"127.0.0.1:40662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/coredns\" "} {"level":"warn","ts":"2026-07-24T22:48:06.802065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.487775ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T22:48:06.802312Z","caller":"traceutil/trace.go:171","msg":"trace[1904454099] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"210.484155ms","start":"2026-07-24T22:48:06.591791Z","end":"2026-07-24T22:48:06.802275Z","steps":["trace[1904454099] 'process raft request' (duration: 38.57115ms)","trace[1904454099] 'compare' (duration: 171.281899ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T22:48:06.802466Z","caller":"traceutil/trace.go:171","msg":"trace[1040197964] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"129.627419ms","start":"2026-07-24T22:48:06.672757Z","end":"2026-07-24T22:48:06.802384Z","steps":["trace[1040197964] 'process raft request' (duration: 129.426254ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:48:06.802492Z","caller":"traceutil/trace.go:171","msg":"trace[226463651] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"192.488058ms","start":"2026-07-24T22:48:06.60999Z","end":"2026-07-24T22:48:06.802478Z","steps":["trace[226463651] 'read index received' (duration: 20.264535ms)","trace[226463651] 'applied index is now lower than readState.Index' (duration: 172.222023ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T22:48:06.802674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.658183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T22:48:06.802718Z","caller":"traceutil/trace.go:171","msg":"trace[1679660364] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:597; }","duration":"192.742836ms","start":"2026-07-24T22:48:06.609961Z","end":"2026-07-24T22:48:06.802703Z","steps":["trace[1679660364] 'agreement among raft nodes before linearized reading' (duration: 192.605552ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:48:06.802869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.785166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T22:48:06.802918Z","caller":"traceutil/trace.go:171","msg":"trace[182793104] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:597; }","duration":"192.847968ms","start":"2026-07-24T22:48:06.610062Z","end":"2026-07-24T22:48:06.80291Z","steps":["trace[182793104] 'agreement among raft nodes before linearized reading' (duration: 192.782746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:48:06.802983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.11382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T22:48:06.803023Z","caller":"traceutil/trace.go:171","msg":"trace[1133942090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"170.192152ms","start":"2026-07-24T22:48:06.632824Z","end":"2026-07-24T22:48:06.803016Z","steps":["trace[1133942090] 'agreement among raft nodes before linearized reading' (duration: 170.14577ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:48:11.535578Z","caller":"traceutil/trace.go:171","msg":"trace[1161032678] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"102.224506ms","start":"2026-07-24T22:48:11.433335Z","end":"2026-07-24T22:48:11.53556Z","steps":["trace[1161032678] 'process raft request' (duration: 72.58586ms)","trace[1161032678] 'compare' (duration: 29.297298ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T22:48:12.131413Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844975727083896,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-24T22:48:12.233739Z","caller":"traceutil/trace.go:171","msg":"trace[801459485] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"645.29716ms","start":"2026-07-24T22:48:11.588367Z","end":"2026-07-24T22:48:12.233664Z","steps":["trace[801459485] 'process raft request' (duration: 557.702336ms)","trace[801459485] 'compare' (duration: 87.42202ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T22:48:12.233899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T22:48:11.588344Z","time spent":"645.470805ms","remote":"127.0.0.1:40748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T22:48:12.284462Z","caller":"traceutil/trace.go:171","msg":"trace[321749100] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"653.977915ms","start":"2026-07-24T22:48:11.630455Z","end":"2026-07-24T22:48:12.284433Z","steps":["trace[321749100] 'read index received' (duration: 515.877138ms)","trace[321749100] 'applied index is now lower than readState.Index' (duration: 138.099937ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T22:48:12.284555Z","caller":"traceutil/trace.go:171","msg":"trace[924897675] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"318.046241ms","start":"2026-07-24T22:48:11.966502Z","end":"2026-07-24T22:48:12.284548Z","steps":["trace[924897675] 'process raft request' (duration: 317.473397ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:48:12.284643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T22:48:11.966476Z","time spent":"318.097661ms","remote":"127.0.0.1:40648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T22:48:12.284704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.636584ms","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-07-24T22:48:12.284768Z","caller":"traceutil/trace.go:171","msg":"trace[1936009602] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"507.733287ms","start":"2026-07-24T22:48:11.777017Z","end":"2026-07-24T22:48:12.284751Z","steps":["trace[1936009602] 'agreement among raft nodes before linearized reading' (duration: 507.551022ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:48:12.28481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T22:48:11.776935Z","time spent":"507.86715ms","remote":"127.0.0.1:40820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-24T22:48:12.284901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.422046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T22:48:12.285046Z","caller":"traceutil/trace.go:171","msg":"trace[667911496] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"654.620751ms","start":"2026-07-24T22:48:11.630399Z","end":"2026-07-24T22:48:12.285019Z","steps":["trace[667911496] 'agreement among raft nodes before linearized reading' (duration: 654.311683ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:48:12.28512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T22:48:11.630368Z","time spent":"654.739844ms","remote":"127.0.0.1:40576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-24T22:48:26.063438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.415087ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-24T22:49:15.847001Z","caller":"traceutil/trace.go:171","msg":"trace[1025597101] linearizableReadLoop","detail":"{readStateIndex:1104; appliedIndex:1103; }","duration":"120.096875ms","start":"2026-07-24T22:49:15.726886Z","end":"2026-07-24T22:49:15.846983Z","steps":["trace[1025597101] 'read index received' (duration: 119.978804ms)","trace[1025597101] 'applied index is now lower than readState.Index' (duration: 117.191µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T22:49:15.847042Z","caller":"traceutil/trace.go:171","msg":"trace[523512780] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"121.582382ms","start":"2026-07-24T22:49:15.725431Z","end":"2026-07-24T22:49:15.847013Z","steps":["trace[523512780] 'process raft request' (duration: 121.440851ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:49:15.847144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.237946ms","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-07-24T22:49:15.847177Z","caller":"traceutil/trace.go:171","msg":"trace[603878320] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1061; }","duration":"120.305568ms","start":"2026-07-24T22:49:15.726862Z","end":"2026-07-24T22:49:15.847168Z","steps":["trace[603878320] 'agreement among raft nodes before linearized reading' (duration: 120.194557ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:49:21.301862Z","caller":"traceutil/trace.go:171","msg":"trace[1630369944] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"100.954127ms","start":"2026-07-24T22:49:21.20088Z","end":"2026-07-24T22:49:21.301834Z","steps":["trace[1630369944] 'process raft request' (duration: 100.788225ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:49:21.608451Z","caller":"traceutil/trace.go:171","msg":"trace[233044793] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"135.547643ms","start":"2026-07-24T22:49:21.472879Z","end":"2026-07-24T22:49:21.608427Z","steps":["trace[233044793] 'process raft request' (duration: 135.404362ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:51:36.190353Z","caller":"traceutil/trace.go:171","msg":"trace[1517857864] transaction","detail":"{read_only:false; response_revision:1521; number_of_response:1; }","duration":"380.877151ms","start":"2026-07-24T22:51:35.809393Z","end":"2026-07-24T22:51:36.19027Z","steps":["trace[1517857864] 'process raft request' (duration: 380.638005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:51:36.190532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T22:51:35.809364Z","time spent":"381.078966ms","remote":"127.0.0.1:40820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T22:56:14.70006Z","caller":"traceutil/trace.go:171","msg":"trace[1127630587] transaction","detail":"{read_only:false; response_revision:2439; number_of_response:1; }","duration":"129.54023ms","start":"2026-07-24T22:56:14.570478Z","end":"2026-07-24T22:56:14.700018Z","steps":["trace[1127630587] 'process raft request' (duration: 129.315075ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:56:40.112459Z","caller":"traceutil/trace.go:171","msg":"trace[685254874] linearizableReadLoop","detail":"{readStateIndex:2651; appliedIndex:2650; }","duration":"123.147204ms","start":"2026-07-24T22:56:39.98929Z","end":"2026-07-24T22:56:40.112437Z","steps":["trace[685254874] 'read index received' (duration: 122.97743ms)","trace[685254874] 'applied index is now lower than readState.Index' (duration: 168.804µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T22:56:40.112525Z","caller":"traceutil/trace.go:171","msg":"trace[1949563671] transaction","detail":"{read_only:false; response_revision:2519; number_of_response:1; }","duration":"125.970533ms","start":"2026-07-24T22:56:39.986531Z","end":"2026-07-24T22:56:40.112501Z","steps":["trace[1949563671] 'process raft request' (duration: 125.783718ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:56:40.112695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.397221ms","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-07-24T22:56:40.112735Z","caller":"traceutil/trace.go:171","msg":"trace[155138741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2519; }","duration":"123.487453ms","start":"2026-07-24T22:56:39.989238Z","end":"2026-07-24T22:56:40.112725Z","steps":["trace[155138741] 'agreement among raft nodes before linearized reading' (duration: 123.294469ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:56:40.281501Z","caller":"traceutil/trace.go:171","msg":"trace[133500396] linearizableReadLoop","detail":"{readStateIndex:2652; appliedIndex:2651; }","duration":"163.101676ms","start":"2026-07-24T22:56:40.118376Z","end":"2026-07-24T22:56:40.281477Z","steps":["trace[133500396] 'read index received' (duration: 137.252827ms)","trace[133500396] 'applied index is now lower than readState.Index' (duration: 25.847979ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T22:56:40.28163Z","caller":"traceutil/trace.go:171","msg":"trace[1827188294] transaction","detail":"{read_only:false; response_revision:2520; number_of_response:1; }","duration":"165.70378ms","start":"2026-07-24T22:56:40.115914Z","end":"2026-07-24T22:56:40.281618Z","steps":["trace[1827188294] 'process raft request' (duration: 139.774939ms)","trace[1827188294] 'compare' (duration: 25.683634ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T22:56:40.281847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.462166ms","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-07-24T22:56:40.281883Z","caller":"traceutil/trace.go:171","msg":"trace[1006699814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2520; }","duration":"163.551738ms","start":"2026-07-24T22:56:40.118322Z","end":"2026-07-24T22:56:40.281874Z","steps":["trace[1006699814] 'agreement among raft nodes before linearized reading' (duration: 163.420455ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:56:40.281959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.982539ms","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-07-24T22:56:40.28206Z","caller":"traceutil/trace.go:171","msg":"trace[406351879] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2520; }","duration":"162.176424ms","start":"2026-07-24T22:56:40.11987Z","end":"2026-07-24T22:56:40.282047Z","steps":["trace[406351879] 'agreement among raft nodes before linearized reading' (duration: 161.842106ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:56:57.292039Z","caller":"traceutil/trace.go:171","msg":"trace[1177584426] linearizableReadLoop","detail":"{readStateIndex:2766; appliedIndex:2765; }","duration":"346.094789ms","start":"2026-07-24T22:56:56.945928Z","end":"2026-07-24T22:56:57.292022Z","steps":["trace[1177584426] 'read index received' (duration: 346.021397ms)","trace[1177584426] 'applied index is now lower than readState.Index' (duration: 72.702µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T22:56:57.292189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.213772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T22:56:57.292213Z","caller":"traceutil/trace.go:171","msg":"trace[374855663] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2628; }","duration":"346.315614ms","start":"2026-07-24T22:56:56.945889Z","end":"2026-07-24T22:56:57.292205Z","steps":["trace[374855663] 'agreement among raft nodes before linearized reading' (duration: 346.207012ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:56:57.292235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T22:56:56.945876Z","time spent":"346.354005ms","remote":"127.0.0.1:40566","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-07-24T22:56:57.292505Z","caller":"traceutil/trace.go:171","msg":"trace[153447154] transaction","detail":"{read_only:false; response_revision:2628; number_of_response:1; }","duration":"418.246405ms","start":"2026-07-24T22:56:56.87425Z","end":"2026-07-24T22:56:57.292496Z","steps":["trace[153447154] 'process raft request' (duration: 417.62605ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:56:57.29256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T22:56:56.874221Z","time spent":"418.300207ms","remote":"127.0.0.1:40820","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-07-24T22:57:12.567723Z","caller":"traceutil/trace.go:171","msg":"trace[1192210341] linearizableReadLoop","detail":"{readStateIndex:2838; appliedIndex:2835; }","duration":"225.476851ms","start":"2026-07-24T22:57:12.342228Z","end":"2026-07-24T22:57:12.567704Z","steps":["trace[1192210341] 'read index received' (duration: 160.399086ms)","trace[1192210341] 'applied index is now lower than readState.Index' (duration: 65.076955ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T22:57:12.567967Z","caller":"traceutil/trace.go:171","msg":"trace[827931882] transaction","detail":"{read_only:false; response_revision:2697; number_of_response:1; }","duration":"263.275682ms","start":"2026-07-24T22:57:12.304671Z","end":"2026-07-24T22:57:12.567947Z","steps":["trace[827931882] 'process raft request' (duration: 262.999995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:57:12.568091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.523748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-07-24T22:57:12.568094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.441802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-24T22:57:12.568143Z","caller":"traceutil/trace.go:171","msg":"trace[1975937835] transaction","detail":"{read_only:false; response_revision:2696; number_of_response:1; }","duration":"266.536211ms","start":"2026-07-24T22:57:12.301599Z","end":"2026-07-24T22:57:12.568135Z","steps":["trace[1975937835] 'process raft request' (duration: 266.031448ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:57:12.56815Z","caller":"traceutil/trace.go:171","msg":"trace[45216454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2697; }","duration":"145.547045ms","start":"2026-07-24T22:57:12.42259Z","end":"2026-07-24T22:57:12.568137Z","steps":["trace[45216454] 'agreement among raft nodes before linearized reading' (duration: 145.36956ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:57:12.568161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.921502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T22:57:12.568183Z","caller":"traceutil/trace.go:171","msg":"trace[1557555668] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:2697; }","duration":"225.983764ms","start":"2026-07-24T22:57:12.342193Z","end":"2026-07-24T22:57:12.568177Z","steps":["trace[1557555668] 'agreement among raft nodes before linearized reading' (duration: 225.940803ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T22:57:12.568198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.498053ms","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-07-24T22:57:12.568261Z","caller":"traceutil/trace.go:171","msg":"trace[416096426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2697; }","duration":"145.592156ms","start":"2026-07-24T22:57:12.422654Z","end":"2026-07-24T22:57:12.568246Z","steps":["trace[416096426] 'agreement among raft nodes before linearized reading' (duration: 145.377681ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:57:12.568117Z","caller":"traceutil/trace.go:171","msg":"trace[1922257752] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2697; }","duration":"139.59614ms","start":"2026-07-24T22:57:12.428514Z","end":"2026-07-24T22:57:12.56811Z","steps":["trace[1922257752] 'agreement among raft nodes before linearized reading' (duration: 139.485427ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:57:12.568333Z","caller":"traceutil/trace.go:171","msg":"trace[80693653] transaction","detail":"{read_only:false; response_revision:2695; number_of_response:1; }","duration":"266.873519ms","start":"2026-07-24T22:57:12.301431Z","end":"2026-07-24T22:57:12.568304Z","steps":["trace[80693653] 'process raft request' (duration: 201.183508ms)","trace[80693653] 'compare' (duration: 64.899322ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T22:57:18.550627Z","caller":"traceutil/trace.go:171","msg":"trace[1819749444] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"204.449679ms","start":"2026-07-24T22:57:18.346152Z","end":"2026-07-24T22:57:18.550602Z","steps":["trace[1819749444] 'process raft request' (duration: 204.261465ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:57:18.550785Z","caller":"traceutil/trace.go:171","msg":"trace[1950598022] linearizableReadLoop","detail":"{readStateIndex:2896; appliedIndex:2893; }","duration":"195.025469ms","start":"2026-07-24T22:57:18.35573Z","end":"2026-07-24T22:57:18.550756Z","steps":["trace[1950598022] 'read index received' (duration: 15.462646ms)","trace[1950598022] 'applied index is now lower than readState.Index' (duration: 179.560893ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T22:57:18.551012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.267185ms","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-07-24T22:57:18.551055Z","caller":"traceutil/trace.go:171","msg":"trace[125512201] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2754; }","duration":"195.353017ms","start":"2026-07-24T22:57:18.355688Z","end":"2026-07-24T22:57:18.551041Z","steps":["trace[125512201] 'agreement among raft nodes before linearized reading' (duration: 195.173402ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:57:18.551068Z","caller":"traceutil/trace.go:171","msg":"trace[328231336] transaction","detail":"{read_only:false; response_revision:2754; number_of_response:1; }","duration":"199.913869ms","start":"2026-07-24T22:57:18.351129Z","end":"2026-07-24T22:57:18.551042Z","steps":["trace[328231336] 'process raft request' (duration: 199.418807ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T22:57:27.746567Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1692} {"level":"info","ts":"2026-07-24T22:57:27.781083Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":1692,"took":"33.910576ms","hash":1904804740,"current-db-size-bytes":23420928,"current-db-size":"23 MB","current-db-size-in-use-bytes":6131712,"current-db-size-in-use":"6.1 MB"} {"level":"info","ts":"2026-07-24T22:57:27.781149Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1904804740,"revision":1692,"compact-revision":-1} {"level":"info","ts":"2026-07-24T23:02:27.75257Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2800} {"level":"info","ts":"2026-07-24T23:02:27.773454Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2800,"took":"20.250151ms","hash":995017278,"current-db-size-bytes":23420928,"current-db-size":"23 MB","current-db-size-in-use-bytes":6586368,"current-db-size-in-use":"6.6 MB"} {"level":"info","ts":"2026-07-24T23:02:27.773508Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":995017278,"revision":2800,"compact-revision":1692}