{"level":"warn","ts":"2026-06-02T06:45:38.753635Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T06:45:38.75374Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-06-02T06:45:38.753827Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T06:45:38.753844Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-06-02T06:45:38.753869Z","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-06-02T06:45:38.754688Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-06-02T06:45:38.754789Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-06-02T06:45:38.758722Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.659349ms"} {"level":"info","ts":"2026-06-02T06:45:38.76511Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-06-02T06:45:38.765183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-06-02T06:45:38.765205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-06-02T06:45:38.765219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-02T06:45:38.765228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-06-02T06:45:38.765269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-06-02T06:45:38.774467Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-02T06:45:38.775624Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-02T06:45:38.776519Z","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-06-02T06:45:38.778378Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-02T06:45:38.778533Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-02T06:45:38.778669Z","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-06-02T06:45:38.778765Z","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-06-02T06:45:38.778782Z","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-06-02T06:45:38.78326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-06-02T06:45:38.783638Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-06-02T06:45:38.786848Z","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-06-02T06:45:38.78693Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-06-02T06:45:38.786973Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-06-02T06:45:38.788048Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-02T06:45:38.788094Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-02T06:45:39.06585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-06-02T06:45:39.065939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-02T06:45:39.065967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-06-02T06:45:39.065987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-06-02T06:45:39.066004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-06-02T06:45:39.06603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-06-02T06:45:39.066049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-06-02T06:45:39.066922Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:45:39.067667Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T06:45:39.067666Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-06-02T06:45:39.067701Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T06:45:39.06823Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-02T06:45:39.068277Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-02T06:45:39.070883Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-06-02T06:45:39.071291Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:45:39.071393Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:45:39.071435Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:45:39.072289Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-02T06:45:48.828581Z","caller":"traceutil/trace.go:171","msg":"trace[1678566497] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:335; }","duration":"120.90231ms","start":"2026-06-02T06:45:48.707652Z","end":"2026-06-02T06:45:48.828555Z","steps":["trace[1678566497] 'read index received' (duration: 116.588105ms)","trace[1678566497] 'applied index is now lower than readState.Index' (duration: 4.313145ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:45:48.828732Z","caller":"traceutil/trace.go:171","msg":"trace[37620374] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"121.886134ms","start":"2026-06-02T06:45:48.70678Z","end":"2026-06-02T06:45:48.828666Z","steps":["trace[37620374] 'process raft request' (duration: 117.485737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:45:48.828814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.129955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-02T06:45:48.828905Z","caller":"traceutil/trace.go:171","msg":"trace[779311563] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:326; }","duration":"121.27121ms","start":"2026-06-02T06:45:48.707621Z","end":"2026-06-02T06:45:48.828892Z","steps":["trace[779311563] 'agreement among raft nodes before linearized reading' (duration: 121.118545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:45:54.765872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.157154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:45:54.766461Z","caller":"traceutil/trace.go:171","msg":"trace[1720521669] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:382; }","duration":"219.06694ms","start":"2026-06-02T06:45:54.547377Z","end":"2026-06-02T06:45:54.766444Z","steps":["trace[1720521669] 'read index received' (duration: 43.321µs)","trace[1720521669] 'applied index is now lower than readState.Index' (duration: 219.022759ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:45:54.766678Z","caller":"traceutil/trace.go:171","msg":"trace[13384417] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"579.530551ms","start":"2026-06-02T06:45:54.187132Z","end":"2026-06-02T06:45:54.766663Z","steps":["trace[13384417] 'process raft request' (duration: 579.259275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:45:54.766884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:45:54.187108Z","time spent":"579.740546ms","remote":"127.0.0.1:58954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:45:54.766746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.365827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:45:54.76671Z","caller":"traceutil/trace.go:171","msg":"trace[1203926022] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"632.239741ms","start":"2026-06-02T06:45:54.134395Z","end":"2026-06-02T06:45:54.766635Z","steps":["trace[1203926022] 'process raft request' (duration: 205.756356ms)","trace[1203926022] 'compare' (duration: 425.02182ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:45:54.768832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:45:54.134383Z","time spent":"634.404644ms","remote":"127.0.0.1:58898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4119,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:45:54.769082Z","caller":"traceutil/trace.go:171","msg":"trace[390736756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:372; }","duration":"221.705593ms","start":"2026-06-02T06:45:54.54733Z","end":"2026-06-02T06:45:54.769035Z","steps":["trace[390736756] 'agreement among raft nodes before linearized reading' (duration: 219.386317ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:45:55.007024Z","caller":"traceutil/trace.go:171","msg":"trace[2112491945] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"144.811945ms","start":"2026-06-02T06:45:54.862184Z","end":"2026-06-02T06:45:55.006996Z","steps":["trace[2112491945] 'process raft request' (duration: 117.802319ms)","trace[2112491945] 'compare' (duration: 26.849142ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:46:14.569352Z","caller":"traceutil/trace.go:171","msg":"trace[314398221] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"237.911838ms","start":"2026-06-02T06:46:14.331415Z","end":"2026-06-02T06:46:14.569326Z","steps":["trace[314398221] 'process raft request' (duration: 233.078561ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:46:14.572421Z","caller":"traceutil/trace.go:171","msg":"trace[1477674503] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"228.034549ms","start":"2026-06-02T06:46:14.344356Z","end":"2026-06-02T06:46:14.57239Z","steps":["trace[1477674503] 'process raft request' (duration: 227.798103ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:46:14.572586Z","caller":"traceutil/trace.go:171","msg":"trace[1509465609] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"161.311744ms","start":"2026-06-02T06:46:14.41126Z","end":"2026-06-02T06:46:14.572572Z","steps":["trace[1509465609] 'process raft request' (duration: 161.104909ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:46:14.572495Z","caller":"traceutil/trace.go:171","msg":"trace[832419136] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"227.958437ms","start":"2026-06-02T06:46:14.344516Z","end":"2026-06-02T06:46:14.572474Z","steps":["trace[832419136] 'process raft request' (duration: 227.772443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:46:20.753464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.891598ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:46:20.753788Z","caller":"traceutil/trace.go:171","msg":"trace[1266663376] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"263.024522ms","start":"2026-06-02T06:46:20.490718Z","end":"2026-06-02T06:46:20.753743Z","steps":["trace[1266663376] 'process raft request' (duration: 73.747353ms)","trace[1266663376] 'compare' (duration: 188.574251ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:46:20.753996Z","caller":"traceutil/trace.go:171","msg":"trace[2108525198] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"256.098904ms","start":"2026-06-02T06:46:20.497846Z","end":"2026-06-02T06:46:20.753944Z","steps":["trace[2108525198] 'process raft request' (duration: 255.847318ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:46:20.754273Z","caller":"traceutil/trace.go:171","msg":"trace[1135579345] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:605; }","duration":"242.651789ms","start":"2026-06-02T06:46:20.511155Z","end":"2026-06-02T06:46:20.753806Z","steps":["trace[1135579345] 'read index received' (duration: 53.274048ms)","trace[1135579345] 'applied index is now lower than readState.Index' (duration: 189.376401ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:46:20.754399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.212123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-02T06:46:20.754662Z","caller":"traceutil/trace.go:171","msg":"trace[376391904] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:588; }","duration":"243.51814ms","start":"2026-06-02T06:46:20.511114Z","end":"2026-06-02T06:46:20.754632Z","steps":["trace[376391904] 'agreement among raft nodes before linearized reading' (duration: 243.033488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:46:21.610557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.534034ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:46:21.610688Z","caller":"traceutil/trace.go:171","msg":"trace[734061592] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"413.179002ms","start":"2026-06-02T06:46:21.197488Z","end":"2026-06-02T06:46:21.610667Z","steps":["trace[734061592] 'process raft request' (duration: 187.453923ms)","trace[734061592] 'compare' (duration: 225.194206ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:46:21.610759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:46:21.197476Z","time spent":"413.252974ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:46:21.951528Z","caller":"traceutil/trace.go:171","msg":"trace[1440827480] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"276.731912ms","start":"2026-06-02T06:46:21.674767Z","end":"2026-06-02T06:46:21.951499Z","steps":["trace[1440827480] 'process raft request' (duration: 276.613579ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:46:21.951553Z","caller":"traceutil/trace.go:171","msg":"trace[1547977455] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"740.749893ms","start":"2026-06-02T06:46:21.210757Z","end":"2026-06-02T06:46:21.951507Z","steps":["trace[1547977455] 'process raft request' (duration: 740.521708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:46:21.951773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:46:21.210743Z","time spent":"740.906537ms","remote":"127.0.0.1:58898","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-06-02T06:46:21.951826Z","caller":"traceutil/trace.go:171","msg":"trace[1426120934] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:608; }","duration":"676.575901ms","start":"2026-06-02T06:46:21.275231Z","end":"2026-06-02T06:46:21.951807Z","steps":["trace[1426120934] 'read index received' (duration: 109.548589ms)","trace[1426120934] 'applied index is now lower than readState.Index' (duration: 567.025742ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:46:21.952068Z","caller":"traceutil/trace.go:171","msg":"trace[99669333] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"751.402631ms","start":"2026-06-02T06:46:21.200648Z","end":"2026-06-02T06:46:21.952051Z","steps":["trace[99669333] 'process raft request' (duration: 663.834972ms)","trace[99669333] 'compare' (duration: 86.475832ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:46:21.952139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:46:21.200627Z","time spent":"751.471063ms","remote":"127.0.0.1:58954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:46:21.95221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.961864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:46:21.952259Z","caller":"traceutil/trace.go:171","msg":"trace[376075651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"405.063267ms","start":"2026-06-02T06:46:21.54718Z","end":"2026-06-02T06:46:21.952244Z","steps":["trace[376075651] 'agreement among raft nodes before linearized reading' (duration: 404.941094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:46:21.952268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.030074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-06-02T06:46:21.952292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:46:21.54716Z","time spent":"405.124859ms","remote":"127.0.0.1:58746","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-06-02T06:46:21.95232Z","caller":"traceutil/trace.go:171","msg":"trace[1344114709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"677.110965ms","start":"2026-06-02T06:46:21.275192Z","end":"2026-06-02T06:46:21.952303Z","steps":["trace[1344114709] 'agreement among raft nodes before linearized reading' (duration: 676.88818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:46:21.952361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:46:21.275152Z","time spent":"677.197367ms","remote":"127.0.0.1:58954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T06:46:21.952354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.235037ms","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-06-02T06:46:21.952437Z","caller":"traceutil/trace.go:171","msg":"trace[424243284] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"208.3534ms","start":"2026-06-02T06:46:21.744059Z","end":"2026-06-02T06:46:21.952412Z","steps":["trace[424243284] 'agreement among raft nodes before linearized reading' (duration: 208.106204ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:46:24.473166Z","caller":"traceutil/trace.go:171","msg":"trace[1559680990] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"139.380719ms","start":"2026-06-02T06:46:24.333726Z","end":"2026-06-02T06:46:24.473106Z","steps":["trace[1559680990] 'process raft request' (duration: 135.735231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:46:36.464018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.932084ms","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":"warn","ts":"2026-06-02T06:46:36.464071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.94543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x2zqz\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-02T06:46:36.464182Z","caller":"traceutil/trace.go:171","msg":"trace[1811624771] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x2zqz; range_end:; response_count:1; response_revision:752; }","duration":"200.107213ms","start":"2026-06-02T06:46:36.26405Z","end":"2026-06-02T06:46:36.464157Z","steps":["trace[1811624771] 'range keys from in-memory index tree' (duration: 199.581962ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:46:36.464168Z","caller":"traceutil/trace.go:171","msg":"trace[1676330899] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:752; }","duration":"112.101228ms","start":"2026-06-02T06:46:36.352025Z","end":"2026-06-02T06:46:36.464126Z","steps":["trace[1676330899] 'range keys from in-memory index tree' (duration: 111.646306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:09.777144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.107745ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:47:09.777768Z","caller":"traceutil/trace.go:171","msg":"trace[1948034888] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"258.520697ms","start":"2026-06-02T06:47:09.519219Z","end":"2026-06-02T06:47:09.77774Z","steps":["trace[1948034888] 'process raft request' (duration: 45.679353ms)","trace[1948034888] 'compare' (duration: 211.915861ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:47:11.89423Z","caller":"traceutil/trace.go:171","msg":"trace[1978644716] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"111.030678ms","start":"2026-06-02T06:47:11.783125Z","end":"2026-06-02T06:47:11.894155Z","steps":["trace[1978644716] 'process raft request' (duration: 53.713716ms)","trace[1978644716] 'compare' (duration: 57.175979ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:47:59.109879Z","caller":"traceutil/trace.go:171","msg":"trace[1116412254] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"438.75275ms","start":"2026-06-02T06:47:58.6711Z","end":"2026-06-02T06:47:59.109853Z","steps":["trace[1116412254] 'process raft request' (duration: 438.581146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:59.110285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:58.671076Z","time spent":"438.894134ms","remote":"127.0.0.1:58898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:47:59.167588Z","caller":"traceutil/trace.go:171","msg":"trace[1272559640] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1919; }","duration":"176.339453ms","start":"2026-06-02T06:47:58.99123Z","end":"2026-06-02T06:47:59.16757Z","steps":["trace[1272559640] 'read index received' (duration: 118.488647ms)","trace[1272559640] 'applied index is now lower than readState.Index' (duration: 57.850116ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:47:59.167661Z","caller":"traceutil/trace.go:171","msg":"trace[1856420405] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"456.459427ms","start":"2026-06-02T06:47:58.711183Z","end":"2026-06-02T06:47:59.167642Z","steps":["trace[1856420405] 'process raft request' (duration: 456.054668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:59.167753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:58.711161Z","time spent":"456.529209ms","remote":"127.0.0.1:58954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:47:59.167858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.635239ms","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-06-02T06:47:59.167922Z","caller":"traceutil/trace.go:171","msg":"trace[1254996414] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1850; }","duration":"176.720651ms","start":"2026-06-02T06:47:58.991173Z","end":"2026-06-02T06:47:59.167893Z","steps":["trace[1254996414] 'agreement among raft nodes before linearized reading' (duration: 176.502956ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:47:59.526319Z","caller":"traceutil/trace.go:171","msg":"trace[970907071] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"347.739385ms","start":"2026-06-02T06:47:59.178555Z","end":"2026-06-02T06:47:59.526294Z","steps":["trace[970907071] 'process raft request' (duration: 347.598992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:47:59.526485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:47:59.178533Z","time spent":"347.872818ms","remote":"127.0.0.1:58898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10967,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:48:37.663758Z","caller":"traceutil/trace.go:171","msg":"trace[479048375] linearizableReadLoop","detail":"{readStateIndex:2191; appliedIndex:2190; }","duration":"142.978328ms","start":"2026-06-02T06:48:37.520753Z","end":"2026-06-02T06:48:37.663732Z","steps":["trace[479048375] 'read index received' (duration: 74.62415ms)","trace[479048375] 'applied index is now lower than readState.Index' (duration: 68.351968ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:48:37.663999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.223724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-06-02T06:48:37.664031Z","caller":"traceutil/trace.go:171","msg":"trace[620951756] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2112; }","duration":"143.291836ms","start":"2026-06-02T06:48:37.520729Z","end":"2026-06-02T06:48:37.664021Z","steps":["trace[620951756] 'agreement among raft nodes before linearized reading' (duration: 143.126592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:48:37.66424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.291119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:48:37.664265Z","caller":"traceutil/trace.go:171","msg":"trace[1302154484] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2113; }","duration":"117.33532ms","start":"2026-06-02T06:48:37.546922Z","end":"2026-06-02T06:48:37.664257Z","steps":["trace[1302154484] 'agreement among raft nodes before linearized reading' (duration: 117.273909ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:38.228606Z","caller":"traceutil/trace.go:171","msg":"trace[1159821953] linearizableReadLoop","detail":"{readStateIndex:2194; appliedIndex:2193; }","duration":"118.464696ms","start":"2026-06-02T06:48:38.110121Z","end":"2026-06-02T06:48:38.228585Z","steps":["trace[1159821953] 'read index received' (duration: 50.863116ms)","trace[1159821953] 'applied index is now lower than readState.Index' (duration: 67.60047ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:38.228745Z","caller":"traceutil/trace.go:171","msg":"trace[1519666651] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"206.314425ms","start":"2026-06-02T06:48:38.022417Z","end":"2026-06-02T06:48:38.228731Z","steps":["trace[1519666651] 'process raft request' (duration: 138.562931ms)","trace[1519666651] 'compare' (duration: 67.415606ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:48:38.228824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.701902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:48:38.229042Z","caller":"traceutil/trace.go:171","msg":"trace[1716616453] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2115; }","duration":"118.901967ms","start":"2026-06-02T06:48:38.110046Z","end":"2026-06-02T06:48:38.228948Z","steps":["trace[1716616453] 'agreement among raft nodes before linearized reading' (duration: 118.730242ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:38.761278Z","caller":"traceutil/trace.go:171","msg":"trace[762683379] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"116.355315ms","start":"2026-06-02T06:48:38.644877Z","end":"2026-06-02T06:48:38.761232Z","steps":["trace[762683379] 'process raft request' (duration: 115.967326ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:48:38.98301Z","caller":"traceutil/trace.go:171","msg":"trace[563932062] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"216.583913ms","start":"2026-06-02T06:48:38.766396Z","end":"2026-06-02T06:48:38.98298Z","steps":["trace[563932062] 'process raft request' (duration: 137.133676ms)","trace[563932062] 'compare' (duration: 79.244532ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:48:38.983261Z","caller":"traceutil/trace.go:171","msg":"trace[430920057] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"201.53781ms","start":"2026-06-02T06:48:38.781676Z","end":"2026-06-02T06:48:38.983213Z","steps":["trace[430920057] 'process raft request' (duration: 201.262884ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:29.426595Z","caller":"traceutil/trace.go:171","msg":"trace[1706695911] transaction","detail":"{read_only:false; response_revision:2498; number_of_response:1; }","duration":"211.374868ms","start":"2026-06-02T06:49:29.215189Z","end":"2026-06-02T06:49:29.426564Z","steps":["trace[1706695911] 'process raft request' (duration: 211.148972ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:49:29.439397Z","caller":"traceutil/trace.go:171","msg":"trace[1802057137] transaction","detail":"{read_only:false; response_revision:2499; number_of_response:1; }","duration":"222.66825ms","start":"2026-06-02T06:49:29.216702Z","end":"2026-06-02T06:49:29.43937Z","steps":["trace[1802057137] 'process raft request' (duration: 222.501546ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:03.378452Z","caller":"traceutil/trace.go:171","msg":"trace[1348955641] transaction","detail":"{read_only:false; response_revision:2686; number_of_response:1; }","duration":"188.142086ms","start":"2026-06-02T06:50:03.190286Z","end":"2026-06-02T06:50:03.378428Z","steps":["trace[1348955641] 'process raft request' (duration: 188.015854ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:03.858588Z","caller":"traceutil/trace.go:171","msg":"trace[2067976630] linearizableReadLoop","detail":"{readStateIndex:2788; appliedIndex:2787; }","duration":"153.994893ms","start":"2026-06-02T06:50:03.704565Z","end":"2026-06-02T06:50:03.85856Z","steps":["trace[2067976630] 'read index received' (duration: 152.502837ms)","trace[2067976630] 'applied index is now lower than readState.Index' (duration: 1.490876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:50:03.858713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.131406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T06:50:03.858736Z","caller":"traceutil/trace.go:171","msg":"trace[1238482236] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:2689; }","duration":"154.215668ms","start":"2026-06-02T06:50:03.704514Z","end":"2026-06-02T06:50:03.858729Z","steps":["trace[1238482236] 'agreement among raft nodes before linearized reading' (duration: 154.129456ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:50:03.858707Z","caller":"traceutil/trace.go:171","msg":"trace[2098013763] transaction","detail":"{read_only:false; response_revision:2689; number_of_response:1; }","duration":"171.590677ms","start":"2026-06-02T06:50:03.68709Z","end":"2026-06-02T06:50:03.85868Z","steps":["trace[2098013763] 'process raft request' (duration: 169.991828ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:53:42.991597Z","caller":"traceutil/trace.go:171","msg":"trace[313641041] transaction","detail":"{read_only:false; response_revision:4542; number_of_response:1; }","duration":"163.877202ms","start":"2026-06-02T06:53:42.827692Z","end":"2026-06-02T06:53:42.991569Z","steps":["trace[313641041] 'process raft request' (duration: 163.601845ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:53:48.747762Z","caller":"traceutil/trace.go:171","msg":"trace[2404240] linearizableReadLoop","detail":"{readStateIndex:4808; appliedIndex:4807; }","duration":"115.424109ms","start":"2026-06-02T06:53:48.632319Z","end":"2026-06-02T06:53:48.747743Z","steps":["trace[2404240] 'read index received' (duration: 100.403803ms)","trace[2404240] 'applied index is now lower than readState.Index' (duration: 15.019116ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:53:48.74789Z","caller":"traceutil/trace.go:171","msg":"trace[1962260809] transaction","detail":"{read_only:false; response_revision:4634; number_of_response:1; }","duration":"269.499962ms","start":"2026-06-02T06:53:48.478343Z","end":"2026-06-02T06:53:48.747843Z","steps":["trace[1962260809] 'process raft request' (duration: 254.382704ms)","trace[1962260809] 'compare' (duration: 14.711167ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:53:48.750217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.890538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-02T06:53:48.750293Z","caller":"traceutil/trace.go:171","msg":"trace[139133133] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4634; }","duration":"117.99748ms","start":"2026-06-02T06:53:48.632265Z","end":"2026-06-02T06:53:48.750263Z","steps":["trace[139133133] 'agreement among raft nodes before linearized reading' (duration: 115.561332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:53:48.75267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.706037ms","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-06-02T06:53:48.752728Z","caller":"traceutil/trace.go:171","msg":"trace[1765261490] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4633; }","duration":"294.764279ms","start":"2026-06-02T06:53:48.457955Z","end":"2026-06-02T06:53:48.752719Z","steps":["trace[1765261490] 'range keys from in-memory index tree' (duration: 289.650539ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:53:49.046146Z","caller":"traceutil/trace.go:171","msg":"trace[401116863] linearizableReadLoop","detail":"{readStateIndex:4822; appliedIndex:4820; }","duration":"120.251543ms","start":"2026-06-02T06:53:48.92587Z","end":"2026-06-02T06:53:49.046122Z","steps":["trace[401116863] 'read index received' (duration: 55.791319ms)","trace[401116863] 'applied index is now lower than readState.Index' (duration: 64.459164ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:53:49.046735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.800075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-06-02T06:53:49.046867Z","caller":"traceutil/trace.go:171","msg":"trace[1809185766] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4648; }","duration":"121.019591ms","start":"2026-06-02T06:53:48.925819Z","end":"2026-06-02T06:53:49.046838Z","steps":["trace[1809185766] 'agreement among raft nodes before linearized reading' (duration: 120.604391ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:53:49.048019Z","caller":"traceutil/trace.go:171","msg":"trace[248803924] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"122.786294ms","start":"2026-06-02T06:53:48.923593Z","end":"2026-06-02T06:53:49.04638Z","steps":["trace[248803924] 'process raft request' (duration: 101.421989ms)","trace[248803924] 'compare' (duration: 20.957235ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:54:01.686912Z","caller":"traceutil/trace.go:171","msg":"trace[1332888924] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"181.2767ms","start":"2026-06-02T06:54:01.5056Z","end":"2026-06-02T06:54:01.686877Z","steps":["trace[1332888924] 'process raft request' (duration: 181.067295ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:39.630653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2875} {"level":"info","ts":"2026-06-02T06:55:39.710982Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2875,"took":"78.890809ms","hash":116693308,"current-db-size-bytes":54534144,"current-db-size":"54 MB","current-db-size-in-use-bytes":29503488,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-02T06:55:39.711147Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":116693308,"revision":2875,"compact-revision":-1} {"level":"info","ts":"2026-06-02T06:57:46.109298Z","caller":"traceutil/trace.go:171","msg":"trace[249497610] linearizableReadLoop","detail":"{readStateIndex:6676; appliedIndex:6675; }","duration":"117.211671ms","start":"2026-06-02T06:57:45.99206Z","end":"2026-06-02T06:57:46.109271Z","steps":["trace[249497610] 'read index received' (duration: 117.081608ms)","trace[249497610] 'applied index is now lower than readState.Index' (duration: 128.923µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:57:46.109409Z","caller":"traceutil/trace.go:171","msg":"trace[1366234593] transaction","detail":"{read_only:false; response_revision:6442; number_of_response:1; }","duration":"117.951988ms","start":"2026-06-02T06:57:45.991424Z","end":"2026-06-02T06:57:46.109376Z","steps":["trace[1366234593] 'process raft request' (duration: 117.671111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:57:46.109674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.581369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:57:46.109731Z","caller":"traceutil/trace.go:171","msg":"trace[643670778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6442; }","duration":"117.677492ms","start":"2026-06-02T06:57:45.992039Z","end":"2026-06-02T06:57:46.109717Z","steps":["trace[643670778] 'agreement among raft nodes before linearized reading' (duration: 117.338864ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:57:46.112816Z","caller":"traceutil/trace.go:171","msg":"trace[825921344] transaction","detail":"{read_only:false; response_revision:6444; number_of_response:1; }","duration":"119.048335ms","start":"2026-06-02T06:57:45.993743Z","end":"2026-06-02T06:57:46.112791Z","steps":["trace[825921344] 'process raft request' (duration: 119.007954ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:57:46.112878Z","caller":"traceutil/trace.go:171","msg":"trace[1638923778] transaction","detail":"{read_only:false; response_revision:6443; number_of_response:1; }","duration":"119.908225ms","start":"2026-06-02T06:57:45.992922Z","end":"2026-06-02T06:57:46.11283Z","steps":["trace[1638923778] 'process raft request' (duration: 119.717431ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:00:39.636705Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5597} {"level":"info","ts":"2026-06-02T07:00:39.72685Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5597,"took":"88.451518ms","hash":2142730593,"current-db-size-bytes":54534144,"current-db-size":"54 MB","current-db-size-in-use-bytes":18280448,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-02T07:00:39.726908Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2142730593,"revision":5597,"compact-revision":2875}