{"level":"warn","ts":"2026-06-30T17:47:06.155086Z","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-30T17:47:06.15519Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-30T17:47:06.15527Z","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-30T17:47:06.155283Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-06-30T17:47:06.155301Z","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-30T17:47:06.156036Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-06-30T17:47:06.156123Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-30T17:47:06.180919Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"24.332581ms"} {"level":"info","ts":"2026-06-30T17:47:06.206935Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-06-30T17:47:06.20711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T17:47:06.207156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-06-30T17:47:06.207182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T17:47:06.207227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-06-30T17:47:06.207284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-06-30T17:47:06.226137Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T17:47:06.230943Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T17:47:06.234199Z","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-30T17:47:06.238868Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T17:47:06.239125Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T17:47:06.23924Z","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-30T17:47:06.239309Z","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-30T17:47:06.239324Z","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-30T17:47:06.243228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-06-30T17:47:06.243437Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-06-30T17:47:06.244933Z","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-30T17:47:06.245289Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T17:47:06.245054Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-06-30T17:47:06.246013Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-06-30T17:47:06.245423Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T17:47:07.208128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T17:47:07.20838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T17:47:07.208553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-06-30T17:47:07.208672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-06-30T17:47:07.208755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-06-30T17:47:07.20883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-06-30T17:47:07.208984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-06-30T17:47:07.223145Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T17:47:07.223142Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:47:07.223405Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:47:07.223251Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:47:07.225907Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-30T17:47:07.22714Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-06-30T17:47:07.227264Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T17:47:07.227356Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T17:47:07.230611Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:47:07.230718Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:47:07.230754Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:47:15.492868Z","caller":"traceutil/trace.go:171","msg":"trace[1292760689] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"143.074091ms","start":"2026-06-30T17:47:15.349771Z","end":"2026-06-30T17:47:15.492845Z","steps":["trace[1292760689] 'process raft request' (duration: 140.441656ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:15.493598Z","caller":"traceutil/trace.go:171","msg":"trace[1637087387] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"140.720706ms","start":"2026-06-30T17:47:15.352855Z","end":"2026-06-30T17:47:15.493576Z","steps":["trace[1637087387] 'process raft request' (duration: 140.548515ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:15.493518Z","caller":"traceutil/trace.go:171","msg":"trace[1275083741] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:353; }","duration":"106.945908ms","start":"2026-06-30T17:47:15.386554Z","end":"2026-06-30T17:47:15.493499Z","steps":["trace[1275083741] 'read index received' (duration: 103.675569ms)","trace[1275083741] 'applied index is now lower than readState.Index' (duration: 3.268939ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:47:15.493888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.277669ms","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-30T17:47:15.493996Z","caller":"traceutil/trace.go:171","msg":"trace[1923569864] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:346; }","duration":"107.48905ms","start":"2026-06-30T17:47:15.386488Z","end":"2026-06-30T17:47:15.493977Z","steps":["trace[1923569864] 'agreement among raft nodes before linearized reading' (duration: 107.185919ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:15.718877Z","caller":"traceutil/trace.go:171","msg":"trace[214077931] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"123.443014ms","start":"2026-06-30T17:47:15.595403Z","end":"2026-06-30T17:47:15.718846Z","steps":["trace[214077931] 'process raft request' (duration: 70.281602ms)","trace[214077931] 'compare' (duration: 53.019552ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:47:15.730301Z","caller":"traceutil/trace.go:171","msg":"trace[860612898] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"134.331909ms","start":"2026-06-30T17:47:15.595945Z","end":"2026-06-30T17:47:15.730277Z","steps":["trace[860612898] 'process raft request' (duration: 134.151948ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:15.730371Z","caller":"traceutil/trace.go:171","msg":"trace[627808462] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"133.692635ms","start":"2026-06-30T17:47:15.59663Z","end":"2026-06-30T17:47:15.730322Z","steps":["trace[627808462] 'process raft request' (duration: 133.575714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:15.944443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.636266ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:47:15.945544Z","caller":"traceutil/trace.go:171","msg":"trace[1455606990] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"158.433241ms","start":"2026-06-30T17:47:15.78702Z","end":"2026-06-30T17:47:15.945453Z","steps":["trace[1455606990] 'process raft request' (duration: 158.23432ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:15.945956Z","caller":"traceutil/trace.go:171","msg":"trace[1963370228] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"208.315174ms","start":"2026-06-30T17:47:15.737592Z","end":"2026-06-30T17:47:15.945907Z","steps":["trace[1963370228] 'process raft request' (duration: 85.692624ms)","trace[1963370228] 'compare' (duration: 118.504856ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:47:15.94662Z","caller":"traceutil/trace.go:171","msg":"trace[1232165041] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"207.456938ms","start":"2026-06-30T17:47:15.739094Z","end":"2026-06-30T17:47:15.946551Z","steps":["trace[1232165041] 'process raft request' (duration: 205.529516ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:15.946703Z","caller":"traceutil/trace.go:171","msg":"trace[258286190] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"207.400218ms","start":"2026-06-30T17:47:15.739128Z","end":"2026-06-30T17:47:15.946528Z","steps":["trace[258286190] 'process raft request' (duration: 205.723317ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:15.94683Z","caller":"traceutil/trace.go:171","msg":"trace[1632589366] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:366; }","duration":"160.045241ms","start":"2026-06-30T17:47:15.786668Z","end":"2026-06-30T17:47:15.946714Z","steps":["trace[1632589366] 'read index received' (duration: 36.625836ms)","trace[1632589366] 'applied index is now lower than readState.Index' (duration: 123.415415ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:47:15.946568Z","caller":"traceutil/trace.go:171","msg":"trace[1615458215] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"206.096001ms","start":"2026-06-30T17:47:15.740436Z","end":"2026-06-30T17:47:15.946532Z","steps":["trace[1615458215] 'process raft request' (duration: 204.528252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:15.947008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.317292ms","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-30T17:47:15.947071Z","caller":"traceutil/trace.go:171","msg":"trace[288544307] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:362; }","duration":"160.416603ms","start":"2026-06-30T17:47:15.786627Z","end":"2026-06-30T17:47:15.947043Z","steps":["trace[288544307] 'agreement among raft nodes before linearized reading' (duration: 160.289692ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:16.129112Z","caller":"traceutil/trace.go:171","msg":"trace[1652745668] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"172.517129ms","start":"2026-06-30T17:47:15.956541Z","end":"2026-06-30T17:47:16.129058Z","steps":["trace[1652745668] 'process raft request' (duration: 128.368082ms)","trace[1652745668] 'compare' (duration: 43.837086ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:47:16.129148Z","caller":"traceutil/trace.go:171","msg":"trace[1336440070] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"171.492914ms","start":"2026-06-30T17:47:15.957626Z","end":"2026-06-30T17:47:16.129119Z","steps":["trace[1336440070] 'process raft request' (duration: 171.278363ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:16.130842Z","caller":"traceutil/trace.go:171","msg":"trace[1239246453] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"101.556174ms","start":"2026-06-30T17:47:16.02927Z","end":"2026-06-30T17:47:16.130826Z","steps":["trace[1239246453] 'process raft request' (duration: 101.510833ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:16.131005Z","caller":"traceutil/trace.go:171","msg":"trace[1850370526] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"104.291769ms","start":"2026-06-30T17:47:16.026703Z","end":"2026-06-30T17:47:16.130994Z","steps":["trace[1850370526] 'process raft request' (duration: 103.929058ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:16.131066Z","caller":"traceutil/trace.go:171","msg":"trace[611995026] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"103.783457ms","start":"2026-06-30T17:47:16.027254Z","end":"2026-06-30T17:47:16.131037Z","steps":["trace[611995026] 'process raft request' (duration: 103.468945ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:16.857358Z","caller":"traceutil/trace.go:171","msg":"trace[1028840681] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"217.754402ms","start":"2026-06-30T17:47:16.639561Z","end":"2026-06-30T17:47:16.857315Z","steps":["trace[1028840681] 'process raft request' (duration: 199.415245ms)","trace[1028840681] 'compare' (duration: 17.985956ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:47:21.703652Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312391830233720,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T17:47:21.714148Z","caller":"traceutil/trace.go:171","msg":"trace[514646797] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"717.605291ms","start":"2026-06-30T17:47:20.996511Z","end":"2026-06-30T17:47:21.714116Z","steps":["trace[514646797] 'process raft request' (duration: 717.38499ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:21.714349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:20.996489Z","time spent":"717.744542ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:47:21.714518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.84846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-30T17:47:21.714798Z","caller":"traceutil/trace.go:171","msg":"trace[648938148] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:414; }","duration":"510.479968ms","start":"2026-06-30T17:47:21.203587Z","end":"2026-06-30T17:47:21.714067Z","steps":["trace[648938148] 'read index received' (duration: 510.217537ms)","trace[648938148] 'applied index is now lower than readState.Index' (duration: 261.141µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:47:21.714725Z","caller":"traceutil/trace.go:171","msg":"trace[562976652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:404; }","duration":"511.209142ms","start":"2026-06-30T17:47:21.203495Z","end":"2026-06-30T17:47:21.714704Z","steps":["trace[562976652] 'agreement among raft nodes before linearized reading' (duration: 510.81729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:21.715363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:21.203463Z","time spent":"511.881876ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T17:47:22.319191Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312391830233722,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:47:22.789499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.324152ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:47:22.789654Z","caller":"traceutil/trace.go:171","msg":"trace[1438152183] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:415; }","duration":"970.712909ms","start":"2026-06-30T17:47:21.818926Z","end":"2026-06-30T17:47:22.789639Z","steps":["trace[1438152183] 'read index received' (duration: 687.248466ms)","trace[1438152183] 'applied index is now lower than readState.Index' (duration: 283.463603ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:47:22.789796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.87453ms","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-30T17:47:22.789823Z","caller":"traceutil/trace.go:171","msg":"trace[818166485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:406; }","duration":"970.94669ms","start":"2026-06-30T17:47:21.818867Z","end":"2026-06-30T17:47:22.789814Z","steps":["trace[818166485] 'agreement among raft nodes before linearized reading' (duration: 970.87094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:22.789855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:21.818845Z","time spent":"971.00246ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-30T17:47:22.789842Z","caller":"traceutil/trace.go:171","msg":"trace[1917545503] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"494.676405ms","start":"2026-06-30T17:47:22.295119Z","end":"2026-06-30T17:47:22.789795Z","steps":["trace[1917545503] 'process raft request' (duration: 494.472864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:22.790013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:22.29509Z","time spent":"494.828216ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:47:22.790036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.624329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:47:22.790116Z","caller":"traceutil/trace.go:171","msg":"trace[808768655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"923.744212ms","start":"2026-06-30T17:47:21.866355Z","end":"2026-06-30T17:47:22.790099Z","steps":["trace[808768655] 'agreement among raft nodes before linearized reading' (duration: 923.6151ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:22.79012Z","caller":"traceutil/trace.go:171","msg":"trace[1227825675] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"1.07031102s","start":"2026-06-30T17:47:21.719777Z","end":"2026-06-30T17:47:22.790088Z","steps":["trace[1227825675] 'process raft request' (duration: 786.309753ms)","trace[1227825675] 'compare' (duration: 283.185712ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:47:22.790158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:21.866334Z","time spent":"923.817002ms","remote":"127.0.0.1:48810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:47:22.790237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:21.719755Z","time spent":"1.07041355s","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:47:23.148851Z","caller":"traceutil/trace.go:171","msg":"trace[1558252744] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"354.579816ms","start":"2026-06-30T17:47:22.794243Z","end":"2026-06-30T17:47:23.148823Z","steps":["trace[1558252744] 'process raft request' (duration: 293.001997ms)","trace[1558252744] 'compare' (duration: 61.388128ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:47:23.149019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:22.794219Z","time spent":"354.710397ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:47:23.163479Z","caller":"traceutil/trace.go:171","msg":"trace[1107216167] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"368.613414ms","start":"2026-06-30T17:47:22.794852Z","end":"2026-06-30T17:47:23.163465Z","steps":["trace[1107216167] 'process raft request' (duration: 368.466913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:23.16357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:22.794836Z","time spent":"368.689245ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:47:23.163655Z","caller":"traceutil/trace.go:171","msg":"trace[1988416373] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:417; }","duration":"366.04379ms","start":"2026-06-30T17:47:22.797565Z","end":"2026-06-30T17:47:23.163608Z","steps":["trace[1988416373] 'read index received' (duration: 289.696707ms)","trace[1988416373] 'applied index is now lower than readState.Index' (duration: 76.345583ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:47:23.163741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.17516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:47:23.163778Z","caller":"traceutil/trace.go:171","msg":"trace[1532071209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"366.24691ms","start":"2026-06-30T17:47:22.797521Z","end":"2026-06-30T17:47:23.163768Z","steps":["trace[1532071209] 'agreement among raft nodes before linearized reading' (duration: 366.18259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:23.163812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:22.797506Z","time spent":"366.29891ms","remote":"127.0.0.1:48812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T17:47:23.163806Z","caller":"traceutil/trace.go:171","msg":"trace[1754259194] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"361.788765ms","start":"2026-06-30T17:47:22.802Z","end":"2026-06-30T17:47:23.163789Z","steps":["trace[1754259194] 'process raft request' (duration: 361.431214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:23.164082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:22.801978Z","time spent":"362.062868ms","remote":"127.0.0.1:48984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7270,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:47:25.625668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.288809ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:47:25.625662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.968838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:47:25.625765Z","caller":"traceutil/trace.go:171","msg":"trace[460118796] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:416; }","duration":"124.42243ms","start":"2026-06-30T17:47:25.501321Z","end":"2026-06-30T17:47:25.625743Z","steps":["trace[460118796] 'range keys from in-memory index tree' (duration: 124.137898ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:25.625794Z","caller":"traceutil/trace.go:171","msg":"trace[1291589508] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:416; }","duration":"300.171719ms","start":"2026-06-30T17:47:25.325588Z","end":"2026-06-30T17:47:25.625759Z","steps":["trace[1291589508] 'range keys from in-memory index tree' (duration: 299.885907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:25.625853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:25.325568Z","time spent":"300.27466ms","remote":"127.0.0.1:48810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T17:47:30.945603Z","caller":"traceutil/trace.go:171","msg":"trace[1046427398] linearizableReadLoop","detail":"{readStateIndex:441; appliedIndex:440; }","duration":"118.201076ms","start":"2026-06-30T17:47:30.827367Z","end":"2026-06-30T17:47:30.945568Z","steps":["trace[1046427398] 'read index received' (duration: 118.0006ms)","trace[1046427398] 'applied index is now lower than readState.Index' (duration: 198.836µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:47:30.945625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:30.408386Z","time spent":"537.230867ms","remote":"127.0.0.1:48838","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-30T17:47:30.945893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.453145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T17:47:30.946036Z","caller":"traceutil/trace.go:171","msg":"trace[1459107704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:428; }","duration":"118.643331ms","start":"2026-06-30T17:47:30.827309Z","end":"2026-06-30T17:47:30.945953Z","steps":["trace[1459107704] 'agreement among raft nodes before linearized reading' (duration: 118.381041ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:31.167147Z","caller":"traceutil/trace.go:171","msg":"trace[1576633156] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"220.263414ms","start":"2026-06-30T17:47:30.94686Z","end":"2026-06-30T17:47:31.167124Z","steps":["trace[1576633156] 'process raft request' (duration: 217.776424ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:31.168232Z","caller":"traceutil/trace.go:171","msg":"trace[1581923253] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"217.303046ms","start":"2026-06-30T17:47:30.950899Z","end":"2026-06-30T17:47:31.168202Z","steps":["trace[1581923253] 'process raft request' (duration: 217.212574ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:41.353444Z","caller":"traceutil/trace.go:171","msg":"trace[1889057764] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"108.514267ms","start":"2026-06-30T17:47:41.24491Z","end":"2026-06-30T17:47:41.353424Z","steps":["trace[1889057764] 'read index received' (duration: 108.415674ms)","trace[1889057764] 'applied index is now lower than readState.Index' (duration: 97.793µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:47:41.35359Z","caller":"traceutil/trace.go:171","msg":"trace[381789294] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"141.257907ms","start":"2026-06-30T17:47:41.212321Z","end":"2026-06-30T17:47:41.353579Z","steps":["trace[381789294] 'process raft request' (duration: 140.98655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:41.353713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.840638ms","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-06-30T17:47:41.353786Z","caller":"traceutil/trace.go:171","msg":"trace[1242700122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:483; }","duration":"106.941871ms","start":"2026-06-30T17:47:41.246826Z","end":"2026-06-30T17:47:41.353768Z","steps":["trace[1242700122] 'agreement among raft nodes before linearized reading' (duration: 106.824247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:41.353967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.046832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-30T17:47:41.354022Z","caller":"traceutil/trace.go:171","msg":"trace[1356622960] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:483; }","duration":"109.103723ms","start":"2026-06-30T17:47:41.244906Z","end":"2026-06-30T17:47:41.354009Z","steps":["trace[1356622960] 'agreement among raft nodes before linearized reading' (duration: 108.99032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:52.389694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.967814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:47:52.38978Z","caller":"traceutil/trace.go:171","msg":"trace[456071481] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:544; }","duration":"343.140129ms","start":"2026-06-30T17:47:52.04662Z","end":"2026-06-30T17:47:52.38976Z","steps":["trace[456071481] 'range keys from in-memory index tree' (duration: 342.852432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:52.389816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:52.046596Z","time spent":"343.212151ms","remote":"127.0.0.1:48900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-06-30T17:47:52.978392Z","caller":"traceutil/trace.go:171","msg":"trace[1727195932] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"194.904198ms","start":"2026-06-30T17:47:52.783458Z","end":"2026-06-30T17:47:52.978362Z","steps":["trace[1727195932] 'process raft request' (duration: 186.626477ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:52.978533Z","caller":"traceutil/trace.go:171","msg":"trace[1070893113] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"193.210434ms","start":"2026-06-30T17:47:52.785272Z","end":"2026-06-30T17:47:52.978483Z","steps":["trace[1070893113] 'process raft request' (duration: 193.010679ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:52.978629Z","caller":"traceutil/trace.go:171","msg":"trace[2088692618] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"178.427559ms","start":"2026-06-30T17:47:52.800189Z","end":"2026-06-30T17:47:52.978617Z","steps":["trace[2088692618] 'process raft request' (duration: 178.179802ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:52.978783Z","caller":"traceutil/trace.go:171","msg":"trace[598177098] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"166.099845ms","start":"2026-06-30T17:47:52.812645Z","end":"2026-06-30T17:47:52.978745Z","steps":["trace[598177098] 'process raft request' (duration: 165.787447ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:52.978936Z","caller":"traceutil/trace.go:171","msg":"trace[1314964368] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"155.001464ms","start":"2026-06-30T17:47:52.823875Z","end":"2026-06-30T17:47:52.978877Z","steps":["trace[1314964368] 'process raft request' (duration: 154.618964ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:52.98098Z","caller":"traceutil/trace.go:171","msg":"trace[355796790] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"126.091407ms","start":"2026-06-30T17:47:52.854872Z","end":"2026-06-30T17:47:52.980964Z","steps":["trace[355796790] 'process raft request' (duration: 126.037076ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:52.981184Z","caller":"traceutil/trace.go:171","msg":"trace[1517097851] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"152.582451ms","start":"2026-06-30T17:47:52.828591Z","end":"2026-06-30T17:47:52.981174Z","steps":["trace[1517097851] 'process raft request' (duration: 151.973366ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:52.981296Z","caller":"traceutil/trace.go:171","msg":"trace[1348497881] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"152.620342ms","start":"2026-06-30T17:47:52.828667Z","end":"2026-06-30T17:47:52.981287Z","steps":["trace[1348497881] 'process raft request' (duration: 152.048058ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:52.981707Z","caller":"traceutil/trace.go:171","msg":"trace[1111374319] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"146.593759ms","start":"2026-06-30T17:47:52.835043Z","end":"2026-06-30T17:47:52.981637Z","steps":["trace[1111374319] 'process raft request' (duration: 145.753007ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.066626Z","caller":"traceutil/trace.go:171","msg":"trace[1982641113] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"102.452839ms","start":"2026-06-30T17:47:52.964145Z","end":"2026-06-30T17:47:53.066598Z","steps":["trace[1982641113] 'process raft request' (duration: 102.330876ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.066936Z","caller":"traceutil/trace.go:171","msg":"trace[320552869] transaction","detail":"{read_only:false; number_of_response:1; response_revision:556; }","duration":"203.421709ms","start":"2026-06-30T17:47:52.863477Z","end":"2026-06-30T17:47:53.066899Z","steps":["trace[320552869] 'process raft request' (duration: 202.796983ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.067008Z","caller":"traceutil/trace.go:171","msg":"trace[258756015] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"206.151178ms","start":"2026-06-30T17:47:52.860846Z","end":"2026-06-30T17:47:53.066997Z","steps":["trace[258756015] 'process raft request' (duration: 205.316437ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.06699Z","caller":"traceutil/trace.go:171","msg":"trace[57022959] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"194.360837ms","start":"2026-06-30T17:47:52.872589Z","end":"2026-06-30T17:47:53.06695Z","steps":["trace[57022959] 'process raft request' (duration: 193.768342ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.067095Z","caller":"traceutil/trace.go:171","msg":"trace[708202198] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"206.716122ms","start":"2026-06-30T17:47:52.860362Z","end":"2026-06-30T17:47:53.067078Z","steps":["trace[708202198] 'process raft request' (duration: 205.653436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.397243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.979617ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:47:53.397646Z","caller":"traceutil/trace.go:171","msg":"trace[1901666407] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"409.84787ms","start":"2026-06-30T17:47:52.987756Z","end":"2026-06-30T17:47:53.397603Z","steps":["trace[1901666407] 'process raft request' (duration: 409.592284ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.397665Z","caller":"traceutil/trace.go:171","msg":"trace[1421201891] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"407.241183ms","start":"2026-06-30T17:47:52.990366Z","end":"2026-06-30T17:47:53.397608Z","steps":["trace[1421201891] 'process raft request' (duration: 407.081339ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.397751Z","caller":"traceutil/trace.go:171","msg":"trace[591859591] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"404.361619ms","start":"2026-06-30T17:47:52.993383Z","end":"2026-06-30T17:47:53.397744Z","steps":["trace[591859591] 'process raft request' (duration: 404.094073ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.397728Z","caller":"traceutil/trace.go:171","msg":"trace[273729796] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"407.461749ms","start":"2026-06-30T17:47:52.99023Z","end":"2026-06-30T17:47:53.397691Z","steps":["trace[273729796] 'process raft request' (duration: 407.203083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.397848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:52.993375Z","time spent":"404.428632ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:47:53.397838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:52.987747Z","time spent":"409.995803ms","remote":"127.0.0.1:49308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T17:47:53.397897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:52.990342Z","time spent":"407.437378ms","remote":"127.0.0.1:49308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:47:53.397914Z","caller":"traceutil/trace.go:171","msg":"trace[1400921110] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"402.80991ms","start":"2026-06-30T17:47:52.995084Z","end":"2026-06-30T17:47:53.397894Z","steps":["trace[1400921110] 'process raft request' (duration: 402.564884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.398075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:52.995079Z","time spent":"402.975855ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:47:53.397916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:52.990222Z","time spent":"407.600362ms","remote":"127.0.0.1:49308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:47:53.397716Z","caller":"traceutil/trace.go:171","msg":"trace[1595178075] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"402.679837ms","start":"2026-06-30T17:47:52.995019Z","end":"2026-06-30T17:47:53.397698Z","steps":["trace[1595178075] 'process raft request' (duration: 402.513893ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.397533Z","caller":"traceutil/trace.go:171","msg":"trace[1070654641] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"412.581689ms","start":"2026-06-30T17:47:52.984893Z","end":"2026-06-30T17:47:53.397475Z","steps":["trace[1070654641] 'process raft request' (duration: 310.292855ms)","trace[1070654641] 'compare' (duration: 101.831752ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:47:53.398285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:52.995011Z","time spent":"403.21833ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:47:53.398348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:52.984869Z","time spent":"413.41329ms","remote":"127.0.0.1:49308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:47:53.398469Z","caller":"traceutil/trace.go:171","msg":"trace[1789940857] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"408.420063ms","start":"2026-06-30T17:47:52.990028Z","end":"2026-06-30T17:47:53.398448Z","steps":["trace[1789940857] 'process raft request' (duration: 407.361917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.39859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:52.99002Z","time spent":"408.497894ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:47:53.918122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.648372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:10089"} {"level":"info","ts":"2026-06-30T17:47:53.918438Z","caller":"traceutil/trace.go:171","msg":"trace[1188446780] transaction","detail":"{read_only:false; number_of_response:1; response_revision:566; }","duration":"840.463202ms","start":"2026-06-30T17:47:53.077923Z","end":"2026-06-30T17:47:53.918387Z","steps":["trace[1188446780] 'process raft request' (duration: 509.4374ms)","trace[1188446780] 'compare' (duration: 330.545629ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:47:53.91847Z","caller":"traceutil/trace.go:171","msg":"trace[1272771659] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"834.532943ms","start":"2026-06-30T17:47:53.083911Z","end":"2026-06-30T17:47:53.918444Z","steps":["trace[1272771659] 'process raft request' (duration: 834.327518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.918678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.077893Z","time spent":"840.652468ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10112,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:47:53.918732Z","caller":"traceutil/trace.go:171","msg":"trace[732492205] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:586; }","duration":"593.984099ms","start":"2026-06-30T17:47:53.324729Z","end":"2026-06-30T17:47:53.918713Z","steps":["trace[732492205] 'read index received' (duration: 262.67707ms)","trace[732492205] 'applied index is now lower than readState.Index' (duration: 331.305939ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:47:53.91877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.083901Z","time spent":"834.80023ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:47:53.918743Z","caller":"traceutil/trace.go:171","msg":"trace[2026289109] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"809.973524ms","start":"2026-06-30T17:47:53.108749Z","end":"2026-06-30T17:47:53.918723Z","steps":["trace[2026289109] 'process raft request' (duration: 809.608195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.918867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.129612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:47:53.918924Z","caller":"traceutil/trace.go:171","msg":"trace[426820031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"594.221815ms","start":"2026-06-30T17:47:53.324687Z","end":"2026-06-30T17:47:53.918909Z","steps":["trace[426820031] 'agreement among raft nodes before linearized reading' (duration: 594.105372ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.918884Z","caller":"traceutil/trace.go:171","msg":"trace[1971742091] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"777.912078ms","start":"2026-06-30T17:47:53.140895Z","end":"2026-06-30T17:47:53.918807Z","steps":["trace[1971742091] 'process raft request' (duration: 777.747124ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.918913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.10873Z","time spent":"810.120688ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:47:53.918978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.324666Z","time spent":"594.298716ms","remote":"127.0.0.1:48810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:47:53.919133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.140864Z","time spent":"778.155444ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:47:53.924886Z","caller":"traceutil/trace.go:171","msg":"trace[484489787] transaction","detail":"{read_only:false; number_of_response:0; response_revision:569; }","duration":"521.017473ms","start":"2026-06-30T17:47:53.403824Z","end":"2026-06-30T17:47:53.924841Z","steps":["trace[484489787] 'process raft request' (duration: 520.881369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.925006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.403813Z","time spent":"521.141195ms","remote":"127.0.0.1:49308","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:47:53.925048Z","caller":"traceutil/trace.go:171","msg":"trace[786010043] transaction","detail":"{read_only:false; number_of_response:0; response_revision:569; }","duration":"521.375622ms","start":"2026-06-30T17:47:53.403647Z","end":"2026-06-30T17:47:53.925023Z","steps":["trace[786010043] 'process raft request' (duration: 520.949151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.925168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.403618Z","time spent":"521.488545ms","remote":"127.0.0.1:49308","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:47:53.925272Z","caller":"traceutil/trace.go:171","msg":"trace[1547608267] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"506.58256ms","start":"2026-06-30T17:47:53.418683Z","end":"2026-06-30T17:47:53.925266Z","steps":["trace[1547608267] 'process raft request' (duration: 506.122768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.92531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.418668Z","time spent":"506.613621ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:47:53.925397Z","caller":"traceutil/trace.go:171","msg":"trace[1214044177] transaction","detail":"{read_only:false; number_of_response:1; response_revision:569; }","duration":"518.671454ms","start":"2026-06-30T17:47:53.406721Z","end":"2026-06-30T17:47:53.925392Z","steps":["trace[1214044177] 'process raft request' (duration: 518.014437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.925423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.406712Z","time spent":"518.695645ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7375,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:47:53.92551Z","caller":"traceutil/trace.go:171","msg":"trace[924709493] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"505.353039ms","start":"2026-06-30T17:47:53.420142Z","end":"2026-06-30T17:47:53.925495Z","steps":["trace[924709493] 'process raft request' (duration: 504.813215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.925596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.420133Z","time spent":"505.42372ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:47:53.925721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.961655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-30T17:47:53.925768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.869292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T17:47:53.925776Z","caller":"traceutil/trace.go:171","msg":"trace[1143624711] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"514.046067ms","start":"2026-06-30T17:47:53.411713Z","end":"2026-06-30T17:47:53.925759Z","steps":["trace[1143624711] 'agreement among raft nodes before linearized reading' (duration: 513.929664ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:53.925803Z","caller":"traceutil/trace.go:171","msg":"trace[887783610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"515.956375ms","start":"2026-06-30T17:47:53.409835Z","end":"2026-06-30T17:47:53.925792Z","steps":["trace[887783610] 'agreement among raft nodes before linearized reading' (duration: 515.886503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.925822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.411691Z","time spent":"514.119208ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:47:53.925832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.409814Z","time spent":"516.012116ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-30T17:47:53.926134Z","caller":"traceutil/trace.go:171","msg":"trace[904810694] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"499.899311ms","start":"2026-06-30T17:47:53.426228Z","end":"2026-06-30T17:47:53.926128Z","steps":["trace[904810694] 'process raft request' (duration: 498.860746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.926125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.80486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-30T17:47:53.926164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.426188Z","time spent":"499.958473ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:47:53.926173Z","caller":"traceutil/trace.go:171","msg":"trace[609733326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"511.850621ms","start":"2026-06-30T17:47:53.414307Z","end":"2026-06-30T17:47:53.926158Z","steps":["trace[609733326] 'agreement among raft nodes before linearized reading' (duration: 511.756089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.926219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.414289Z","time spent":"511.918853ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-30T17:47:53.92626Z","caller":"traceutil/trace.go:171","msg":"trace[884583642] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"469.26431ms","start":"2026-06-30T17:47:53.456989Z","end":"2026-06-30T17:47:53.926254Z","steps":["trace[884583642] 'process raft request' (duration: 468.235925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.926287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.456955Z","time spent":"469.317122ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:47:53.926461Z","caller":"traceutil/trace.go:171","msg":"trace[406971625] transaction","detail":"{read_only:false; number_of_response:0; response_revision:569; }","duration":"522.672495ms","start":"2026-06-30T17:47:53.403769Z","end":"2026-06-30T17:47:53.926441Z","steps":["trace[406971625] 'process raft request' (duration: 520.90854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:47:53.92651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:53.403761Z","time spent":"522.722686ms","remote":"127.0.0.1:49308","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:47:59.159401Z","caller":"traceutil/trace.go:171","msg":"trace[947143535] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"219.85786ms","start":"2026-06-30T17:47:58.939479Z","end":"2026-06-30T17:47:59.159336Z","steps":["trace[947143535] 'process raft request' (duration: 218.984239ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:59.497705Z","caller":"traceutil/trace.go:171","msg":"trace[1214041926] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"173.824078ms","start":"2026-06-30T17:47:59.323849Z","end":"2026-06-30T17:47:59.497673Z","steps":["trace[1214041926] 'read index received' (duration: 173.646903ms)","trace[1214041926] 'applied index is now lower than readState.Index' (duration: 175.805µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:47:59.497896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.009742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:47:59.497942Z","caller":"traceutil/trace.go:171","msg":"trace[182883026] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"174.124335ms","start":"2026-06-30T17:47:59.323805Z","end":"2026-06-30T17:47:59.49793Z","steps":["trace[182883026] 'agreement among raft nodes before linearized reading' (duration: 173.986301ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:47:59.498362Z","caller":"traceutil/trace.go:171","msg":"trace[1257516792] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"177.208656ms","start":"2026-06-30T17:47:59.321143Z","end":"2026-06-30T17:47:59.498351Z","steps":["trace[1257516792] 'process raft request' (duration: 176.342265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:00.463915Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312391830234201,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:48:00.772036Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.086262719s","expected-duration":"1s"} {"level":"info","ts":"2026-06-30T17:48:00.774386Z","caller":"traceutil/trace.go:171","msg":"trace[695782490] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"1.090271001s","start":"2026-06-30T17:47:59.684066Z","end":"2026-06-30T17:48:00.774337Z","steps":["trace[695782490] 'process raft request' (duration: 1.088637153s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:00.774737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:59.684033Z","time spent":"1.090447587s","remote":"127.0.0.1:48900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:48:00.785282Z","caller":"traceutil/trace.go:171","msg":"trace[928696225] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:674; }","duration":"821.430867ms","start":"2026-06-30T17:47:59.9638Z","end":"2026-06-30T17:48:00.785231Z","steps":["trace[928696225] 'read index received' (duration: 808.647218ms)","trace[928696225] 'applied index is now lower than readState.Index' (duration: 12.782709ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:48:00.785489Z","caller":"traceutil/trace.go:171","msg":"trace[486737648] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"981.257754ms","start":"2026-06-30T17:47:59.804213Z","end":"2026-06-30T17:48:00.785471Z","steps":["trace[486737648] 'process raft request' (duration: 980.858195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:00.785662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:59.804186Z","time spent":"981.345535ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:48:00.785635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.820607ms","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-30T17:48:00.785734Z","caller":"traceutil/trace.go:171","msg":"trace[1419286385] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"821.980612ms","start":"2026-06-30T17:47:59.963727Z","end":"2026-06-30T17:48:00.785708Z","steps":["trace[1419286385] 'agreement among raft nodes before linearized reading' (duration: 821.740566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:00.785817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:59.963696Z","time spent":"822.082564ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:48:00.785992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.128528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-30T17:48:00.78603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.650179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:48:00.786066Z","caller":"traceutil/trace.go:171","msg":"trace[44402039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"459.744691ms","start":"2026-06-30T17:48:00.326309Z","end":"2026-06-30T17:48:00.786054Z","steps":["trace[44402039] 'agreement among raft nodes before linearized reading' (duration: 459.677319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:00.786102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:00.326278Z","time spent":"459.818663ms","remote":"127.0.0.1:48810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:48:00.78618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.621841ms","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-30T17:48:00.786221Z","caller":"traceutil/trace.go:171","msg":"trace[1865831868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:650; }","duration":"804.692002ms","start":"2026-06-30T17:47:59.981511Z","end":"2026-06-30T17:48:00.786203Z","steps":["trace[1865831868] 'agreement among raft nodes before linearized reading' (duration: 804.481658ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:00.786035Z","caller":"traceutil/trace.go:171","msg":"trace[411713969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:650; }","duration":"812.194859ms","start":"2026-06-30T17:47:59.973827Z","end":"2026-06-30T17:48:00.786022Z","steps":["trace[411713969] 'agreement among raft nodes before linearized reading' (duration: 812.078697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:00.786296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:59.973815Z","time spent":"812.470706ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T17:48:00.786303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.565969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-06-30T17:48:00.786334Z","caller":"traceutil/trace.go:171","msg":"trace[400066995] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:650; }","duration":"377.62568ms","start":"2026-06-30T17:48:00.408699Z","end":"2026-06-30T17:48:00.786324Z","steps":["trace[400066995] 'agreement among raft nodes before linearized reading' (duration: 377.567549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:00.786371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:00.408686Z","time spent":"377.678802ms","remote":"127.0.0.1:48838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "} {"level":"warn","ts":"2026-06-30T17:48:00.786239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:59.98143Z","time spent":"804.804365ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T17:48:00.78663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.527727ms","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-06-30T17:48:00.786666Z","caller":"traceutil/trace.go:171","msg":"trace[694901239] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:650; }","duration":"812.61561ms","start":"2026-06-30T17:47:59.974041Z","end":"2026-06-30T17:48:00.786656Z","steps":["trace[694901239] 'agreement among raft nodes before linearized reading' (duration: 812.343333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:00.786806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:47:59.974009Z","time spent":"812.787893ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T17:48:02.054738Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.221244175s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-30T17:48:02.070055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.240394825s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:420"} {"level":"info","ts":"2026-06-30T17:48:02.070106Z","caller":"traceutil/trace.go:171","msg":"trace[1431208776] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:682; }","duration":"282.336109ms","start":"2026-06-30T17:48:01.787748Z","end":"2026-06-30T17:48:02.070084Z","steps":["trace[1431208776] 'read index received' (duration: 267.141151ms)","trace[1431208776] 'applied index is now lower than readState.Index' (duration: 15.194178ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:48:02.070138Z","caller":"traceutil/trace.go:171","msg":"trace[1486248729] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:655; }","duration":"1.240506888s","start":"2026-06-30T17:48:00.82961Z","end":"2026-06-30T17:48:02.070117Z","steps":["trace[1486248729] 'range keys from in-memory index tree' (duration: 1.240300723s)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:02.070127Z","caller":"traceutil/trace.go:171","msg":"trace[1044899195] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"1.236698259s","start":"2026-06-30T17:48:00.833394Z","end":"2026-06-30T17:48:02.070093Z","steps":["trace[1044899195] 'process raft request' (duration: 1.221550652s)","trace[1044899195] 'compare' (duration: 14.757048ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:48:02.070169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:00.829594Z","time spent":"1.240568709s","remote":"127.0.0.1:48966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":443,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-06-30T17:48:02.07026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.504033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:48:02.070286Z","caller":"traceutil/trace.go:171","msg":"trace[2002679576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"282.599406ms","start":"2026-06-30T17:48:01.787679Z","end":"2026-06-30T17:48:02.070278Z","steps":["trace[2002679576] 'agreement among raft nodes before linearized reading' (duration: 282.461883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:02.070274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:00.833373Z","time spent":"1.236826071s","remote":"127.0.0.1:49144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T17:48:03.85516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.594102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:48:03.855305Z","caller":"traceutil/trace.go:171","msg":"trace[559797206] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"373.45955ms","start":"2026-06-30T17:48:03.481822Z","end":"2026-06-30T17:48:03.855282Z","steps":["trace[559797206] 'process raft request' (duration: 123.639164ms)","trace[559797206] 'compare' (duration: 249.385476ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:48:03.855388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:03.481786Z","time spent":"373.570832ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:48:03.860034Z","caller":"traceutil/trace.go:171","msg":"trace[1509498430] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"371.78218ms","start":"2026-06-30T17:48:03.488219Z","end":"2026-06-30T17:48:03.860002Z","steps":["trace[1509498430] 'process raft request' (duration: 371.711129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:03.86015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:03.488207Z","time spent":"371.876323ms","remote":"127.0.0.1:48850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5562,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:48:03.860169Z","caller":"traceutil/trace.go:171","msg":"trace[419036454] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"372.789714ms","start":"2026-06-30T17:48:03.487331Z","end":"2026-06-30T17:48:03.86012Z","steps":["trace[419036454] 'process raft request' (duration: 372.516628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:03.860402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:03.487318Z","time spent":"372.958907ms","remote":"127.0.0.1:49308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":932,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:48:03.864776Z","caller":"traceutil/trace.go:171","msg":"trace[1297032413] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"189.312894ms","start":"2026-06-30T17:48:03.675442Z","end":"2026-06-30T17:48:03.864754Z","steps":["trace[1297032413] 'process raft request' (duration: 189.197721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:17.619627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.497559ms","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-30T17:48:17.619739Z","caller":"traceutil/trace.go:171","msg":"trace[862801858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:820; }","duration":"712.687743ms","start":"2026-06-30T17:48:16.90703Z","end":"2026-06-30T17:48:17.619718Z","steps":["trace[862801858] 'range keys from in-memory index tree' (duration: 712.289504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:17.619748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.343037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-30T17:48:17.619791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:16.906999Z","time spent":"712.782484ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T17:48:17.619806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.341536ms","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-06-30T17:48:17.619844Z","caller":"traceutil/trace.go:171","msg":"trace[1428897106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:820; }","duration":"713.475449ms","start":"2026-06-30T17:48:16.906346Z","end":"2026-06-30T17:48:17.619822Z","steps":["trace[1428897106] 'range keys from in-memory index tree' (duration: 713.149972ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:17.619883Z","caller":"traceutil/trace.go:171","msg":"trace[1644073530] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:820; }","duration":"713.438398ms","start":"2026-06-30T17:48:16.906425Z","end":"2026-06-30T17:48:17.619863Z","steps":["trace[1644073530] 'range keys from in-memory index tree' (duration: 713.136432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:17.619892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:16.906339Z","time spent":"713.54363ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T17:48:17.619869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.387967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:48:17.619997Z","caller":"traceutil/trace.go:171","msg":"trace[166603288] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:820; }","duration":"293.55903ms","start":"2026-06-30T17:48:17.326408Z","end":"2026-06-30T17:48:17.619967Z","steps":["trace[166603288] 'range keys from in-memory index tree' (duration: 293.308515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:17.619919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:16.90642Z","time spent":"713.493249ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T17:48:17.620592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.810914ms","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-30T17:48:17.620836Z","caller":"traceutil/trace.go:171","msg":"trace[1353109280] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:820; }","duration":"715.10473ms","start":"2026-06-30T17:48:16.905705Z","end":"2026-06-30T17:48:17.62081Z","steps":["trace[1353109280] 'range keys from in-memory index tree' (duration: 713.785434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:17.62089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:48:16.905683Z","time spent":"715.195122ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-30T17:48:17.670123Z","caller":"traceutil/trace.go:171","msg":"trace[367194413] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"238.210505ms","start":"2026-06-30T17:48:17.43189Z","end":"2026-06-30T17:48:17.6701Z","steps":["trace[367194413] 'process raft request' (duration: 237.46872ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:17.854021Z","caller":"traceutil/trace.go:171","msg":"trace[185258204] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"228.974962ms","start":"2026-06-30T17:48:17.625013Z","end":"2026-06-30T17:48:17.853988Z","steps":["trace[185258204] 'process raft request' (duration: 228.853079ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:17.854027Z","caller":"traceutil/trace.go:171","msg":"trace[1755202618] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"228.745946ms","start":"2026-06-30T17:48:17.625215Z","end":"2026-06-30T17:48:17.853961Z","steps":["trace[1755202618] 'process raft request' (duration: 227.667955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:17.85418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.515936ms","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-30T17:48:17.854264Z","caller":"traceutil/trace.go:171","msg":"trace[1619947630] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:825; }","duration":"211.635718ms","start":"2026-06-30T17:48:17.642603Z","end":"2026-06-30T17:48:17.854238Z","steps":["trace[1619947630] 'agreement among raft nodes before linearized reading' (duration: 211.371903ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:17.854272Z","caller":"traceutil/trace.go:171","msg":"trace[1937227087] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"229.017662ms","start":"2026-06-30T17:48:17.625229Z","end":"2026-06-30T17:48:17.854247Z","steps":["trace[1937227087] 'process raft request' (duration: 228.575513ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:17.854333Z","caller":"traceutil/trace.go:171","msg":"trace[2142286440] linearizableReadLoop","detail":"{readStateIndex:857; appliedIndex:853; }","duration":"184.41681ms","start":"2026-06-30T17:48:17.669549Z","end":"2026-06-30T17:48:17.853966Z","steps":["trace[2142286440] 'read index received' (duration: 183.241917ms)","trace[2142286440] 'applied index is now lower than readState.Index' (duration: 1.173643ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:48:17.854416Z","caller":"traceutil/trace.go:171","msg":"trace[2032725910] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"227.509282ms","start":"2026-06-30T17:48:17.626896Z","end":"2026-06-30T17:48:17.854405Z","steps":["trace[2032725910] 'process raft request' (duration: 227.015182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:17.85457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.179434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:48:17.854637Z","caller":"traceutil/trace.go:171","msg":"trace[1792602186] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:825; }","duration":"142.305796ms","start":"2026-06-30T17:48:17.71232Z","end":"2026-06-30T17:48:17.854626Z","steps":["trace[1792602186] 'agreement among raft nodes before linearized reading' (duration: 142.139593ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:40.151191Z","caller":"traceutil/trace.go:171","msg":"trace[1234005027] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"159.106094ms","start":"2026-06-30T17:48:39.992053Z","end":"2026-06-30T17:48:40.151159Z","steps":["trace[1234005027] 'process raft request' (duration: 158.937011ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:40.192954Z","caller":"traceutil/trace.go:171","msg":"trace[610598879] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"200.041138ms","start":"2026-06-30T17:48:39.992882Z","end":"2026-06-30T17:48:40.192923Z","steps":["trace[610598879] 'process raft request' (duration: 199.837525ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:40.193318Z","caller":"traceutil/trace.go:171","msg":"trace[2022419840] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1056; }","duration":"191.288655ms","start":"2026-06-30T17:48:40.001997Z","end":"2026-06-30T17:48:40.193286Z","steps":["trace[2022419840] 'read index received' (duration: 149.076711ms)","trace[2022419840] 'applied index is now lower than readState.Index' (duration: 42.207704ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:48:40.193434Z","caller":"traceutil/trace.go:171","msg":"trace[1242859933] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"197.246242ms","start":"2026-06-30T17:48:39.996165Z","end":"2026-06-30T17:48:40.193411Z","steps":["trace[1242859933] 'process raft request' (duration: 196.711884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:40.193563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.538469ms","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-30T17:48:40.193634Z","caller":"traceutil/trace.go:171","msg":"trace[191505437] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1022; }","duration":"191.623211ms","start":"2026-06-30T17:48:40.001994Z","end":"2026-06-30T17:48:40.193617Z","steps":["trace[191505437] 'agreement among raft nodes before linearized reading' (duration: 191.439968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:40.193798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.699979ms","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-30T17:48:40.193996Z","caller":"traceutil/trace.go:171","msg":"trace[2058388932] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1022; }","duration":"189.824762ms","start":"2026-06-30T17:48:40.004044Z","end":"2026-06-30T17:48:40.193869Z","steps":["trace[2058388932] 'agreement among raft nodes before linearized reading' (duration: 189.430004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:40.472761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.016731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:48:40.472972Z","caller":"traceutil/trace.go:171","msg":"trace[2052845605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1024; }","duration":"146.294255ms","start":"2026-06-30T17:48:40.326654Z","end":"2026-06-30T17:48:40.472949Z","steps":["trace[2052845605] 'range keys from in-memory index tree' (duration: 145.909759ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:40.749365Z","caller":"traceutil/trace.go:171","msg":"trace[2125014527] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"148.822275ms","start":"2026-06-30T17:48:40.600506Z","end":"2026-06-30T17:48:40.749328Z","steps":["trace[2125014527] 'process raft request' (duration: 148.618982ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:41.164424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.748598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:48:41.164562Z","caller":"traceutil/trace.go:171","msg":"trace[1688501000] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1026; }","duration":"285.96218ms","start":"2026-06-30T17:48:40.878569Z","end":"2026-06-30T17:48:41.164532Z","steps":["trace[1688501000] 'count revisions from in-memory index tree' (duration: 285.641425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:41.164895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.105543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:48:41.164988Z","caller":"traceutil/trace.go:171","msg":"trace[1880240825] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1026; }","duration":"286.297726ms","start":"2026-06-30T17:48:40.878668Z","end":"2026-06-30T17:48:41.164965Z","steps":["trace[1880240825] 'count revisions from in-memory index tree' (duration: 285.96758ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:48.335979Z","caller":"traceutil/trace.go:171","msg":"trace[1648895961] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"107.794766ms","start":"2026-06-30T17:48:48.228166Z","end":"2026-06-30T17:48:48.33596Z","steps":["trace[1648895961] 'process raft request' (duration: 107.698804ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:48.35548Z","caller":"traceutil/trace.go:171","msg":"trace[684848578] linearizableReadLoop","detail":"{readStateIndex:1088; appliedIndex:1087; }","duration":"111.751657ms","start":"2026-06-30T17:48:48.243671Z","end":"2026-06-30T17:48:48.355423Z","steps":["trace[684848578] 'read index received' (duration: 92.358251ms)","trace[684848578] 'applied index is now lower than readState.Index' (duration: 19.392236ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:48:48.355693Z","caller":"traceutil/trace.go:171","msg":"trace[2050863759] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"123.75822ms","start":"2026-06-30T17:48:48.231901Z","end":"2026-06-30T17:48:48.35566Z","steps":["trace[2050863759] 'process raft request' (duration: 123.379635ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:48.35583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.138742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:48:48.355874Z","caller":"traceutil/trace.go:171","msg":"trace[1721968378] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1049; }","duration":"112.221343ms","start":"2026-06-30T17:48:48.24364Z","end":"2026-06-30T17:48:48.355861Z","steps":["trace[1721968378] 'agreement among raft nodes before linearized reading' (duration: 112.00911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:48:48.533072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.523342ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:48:48.533297Z","caller":"traceutil/trace.go:171","msg":"trace[1948787623] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"172.377631ms","start":"2026-06-30T17:48:48.360899Z","end":"2026-06-30T17:48:48.533276Z","steps":["trace[1948787623] 'process raft request' (duration: 172.32631ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:48.533437Z","caller":"traceutil/trace.go:171","msg":"trace[378351702] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"173.033382ms","start":"2026-06-30T17:48:48.360394Z","end":"2026-06-30T17:48:48.533428Z","steps":["trace[378351702] 'process raft request' (duration: 172.779348ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:48:48.533533Z","caller":"traceutil/trace.go:171","msg":"trace[1354537174] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"173.58396ms","start":"2026-06-30T17:48:48.359936Z","end":"2026-06-30T17:48:48.53352Z","steps":["trace[1354537174] 'process raft request' (duration: 63.478508ms)","trace[1354537174] 'compare' (duration: 109.39703ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:49:02.618579Z","caller":"traceutil/trace.go:171","msg":"trace[2085213005] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"137.464353ms","start":"2026-06-30T17:49:02.481076Z","end":"2026-06-30T17:49:02.618541Z","steps":["trace[2085213005] 'process raft request' (duration: 95.329109ms)","trace[2085213005] 'compare' (duration: 41.779668ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:49:10.890976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.308235ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:49:10.891111Z","caller":"traceutil/trace.go:171","msg":"trace[1123375134] linearizableReadLoop","detail":"{readStateIndex:1172; appliedIndex:1171; }","duration":"165.823292ms","start":"2026-06-30T17:49:10.725265Z","end":"2026-06-30T17:49:10.891088Z","steps":["trace[1123375134] 'read index received' (duration: 32.211083ms)","trace[1123375134] 'applied index is now lower than readState.Index' (duration: 133.610219ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:49:10.891223Z","caller":"traceutil/trace.go:171","msg":"trace[1522772710] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"187.790601ms","start":"2026-06-30T17:49:10.703416Z","end":"2026-06-30T17:49:10.891207Z","steps":["trace[1522772710] 'process raft request' (duration: 54.129682ms)","trace[1522772710] 'compare' (duration: 133.149303ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:49:10.891428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.779795ms","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-30T17:49:10.891464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.174186ms","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-30T17:49:10.891529Z","caller":"traceutil/trace.go:171","msg":"trace[609898130] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1127; }","duration":"144.928677ms","start":"2026-06-30T17:49:10.746575Z","end":"2026-06-30T17:49:10.891503Z","steps":["trace[609898130] 'agreement among raft nodes before linearized reading' (duration: 144.664884ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:49:10.891556Z","caller":"traceutil/trace.go:171","msg":"trace[802993635] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1127; }","duration":"166.306358ms","start":"2026-06-30T17:49:10.725231Z","end":"2026-06-30T17:49:10.891538Z","steps":["trace[802993635] 'agreement among raft nodes before linearized reading' (duration: 166.022735ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:49:13.077606Z","caller":"traceutil/trace.go:171","msg":"trace[1702357088] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"103.804774ms","start":"2026-06-30T17:49:12.973767Z","end":"2026-06-30T17:49:13.077572Z","steps":["trace[1702357088] 'process raft request' (duration: 99.556019ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:49:59.705258Z","caller":"traceutil/trace.go:171","msg":"trace[438389956] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"123.957742ms","start":"2026-06-30T17:49:59.581273Z","end":"2026-06-30T17:49:59.705231Z","steps":["trace[438389956] 'process raft request' (duration: 99.703609ms)","trace[438389956] 'compare' (duration: 24.123022ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:50:07.53144Z","caller":"traceutil/trace.go:171","msg":"trace[704815673] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"157.209975ms","start":"2026-06-30T17:50:07.374198Z","end":"2026-06-30T17:50:07.531408Z","steps":["trace[704815673] 'process raft request' (duration: 156.976663ms)"],"step_count":1}