{"level":"warn","ts":"2026-07-06T23:14:02.916718Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-06T23:14:02.91685Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-06T23:14:02.916949Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-06T23:14:02.916962Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-07-06T23:14:02.916998Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-06T23:14:02.917684Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-07-06T23:14:02.917765Z","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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-06T23:14:02.928302Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.310681ms"} {"level":"info","ts":"2026-07-06T23:14:02.93555Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-07-06T23:14:02.935646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-07-06T23:14:02.935679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-07-06T23:14:02.935694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-06T23:14:02.935711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-07-06T23:14:02.935756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-07-06T23:14:02.940964Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-06T23:14:02.942165Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-06T23:14:02.943063Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-06T23:14:02.946146Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-06T23:14:02.946763Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-06T23:14:02.94851Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-06T23:14:02.948588Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-06T23:14:02.948615Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-06T23:14:02.949041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-07-06T23:14:02.953833Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-07-06T23:14:02.954763Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-06T23:14:02.959145Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-06T23:14:02.959184Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-06T23:14:02.959221Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-07-06T23:14:02.959234Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-07-06T23:14:03.036296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-07-06T23:14:03.036371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-06T23:14:03.03641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-07-06T23:14:03.036432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-07-06T23:14:03.036444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-07-06T23:14:03.036474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-07-06T23:14:03.036513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-07-06T23:14:03.037321Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T23:14:03.038065Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-07-06T23:14:03.038268Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-06T23:14:03.03841Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-06T23:14:03.04195Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-07-06T23:14:03.041961Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-06T23:14:03.042295Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-06T23:14:03.042357Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-06T23:14:03.042455Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T23:14:03.042549Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T23:14:03.042582Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T23:14:06.285972Z","caller":"traceutil/trace.go:171","msg":"trace[1962675269] transaction","detail":"{read_only:false; response_revision:172; number_of_response:1; }","duration":"118.751361ms","start":"2026-07-06T23:14:06.167197Z","end":"2026-07-06T23:14:06.285949Z","steps":["trace[1962675269] 'process raft request' (duration: 116.289956ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:08.505475Z","caller":"traceutil/trace.go:171","msg":"trace[1516421954] transaction","detail":"{read_only:false; number_of_response:0; response_revision:228; }","duration":"118.848248ms","start":"2026-07-06T23:14:08.386595Z","end":"2026-07-06T23:14:08.505443Z","steps":["trace[1516421954] 'process raft request' (duration: 87.687499ms)","trace[1516421954] 'compare' (duration: 31.103138ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:08.505736Z","caller":"traceutil/trace.go:171","msg":"trace[922232615] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"101.087189ms","start":"2026-07-06T23:14:08.404617Z","end":"2026-07-06T23:14:08.505704Z","steps":["trace[922232615] 'process raft request' (duration: 100.958146ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:08.505745Z","caller":"traceutil/trace.go:171","msg":"trace[1810236529] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"118.743126ms","start":"2026-07-06T23:14:08.386939Z","end":"2026-07-06T23:14:08.505683Z","steps":["trace[1810236529] 'process raft request' (duration: 118.523602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:08.728007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.756125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-06T23:14:08.728261Z","caller":"traceutil/trace.go:171","msg":"trace[1676976332] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"178.258077ms","start":"2026-07-06T23:14:08.549944Z","end":"2026-07-06T23:14:08.728202Z","steps":["trace[1676976332] 'process raft request' (duration: 59.783687ms)","trace[1676976332] 'compare' (duration: 117.664314ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:08.728318Z","caller":"traceutil/trace.go:171","msg":"trace[1832591531] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"122.797108ms","start":"2026-07-06T23:14:08.605502Z","end":"2026-07-06T23:14:08.728299Z","steps":["trace[1832591531] 'process raft request' (duration: 122.692516ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:08.728448Z","caller":"traceutil/trace.go:171","msg":"trace[284643522] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"146.908094ms","start":"2026-07-06T23:14:08.581497Z","end":"2026-07-06T23:14:08.728405Z","steps":["trace[284643522] 'process raft request' (duration: 146.647119ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:08.728564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.192431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:14:08.728636Z","caller":"traceutil/trace.go:171","msg":"trace[1138058785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:241; }","duration":"158.281243ms","start":"2026-07-06T23:14:08.570346Z","end":"2026-07-06T23:14:08.728628Z","steps":["trace[1138058785] 'agreement among raft nodes before linearized reading' (duration: 158.184831ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:08.728489Z","caller":"traceutil/trace.go:171","msg":"trace[484272852] linearizableReadLoop","detail":"{readStateIndex:246; appliedIndex:245; }","duration":"150.561208ms","start":"2026-07-06T23:14:08.577916Z","end":"2026-07-06T23:14:08.728477Z","steps":["trace[484272852] 'read index received' (duration: 31.832563ms)","trace[484272852] 'applied index is now lower than readState.Index' (duration: 118.727415ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:38.213696Z","caller":"traceutil/trace.go:171","msg":"trace[1591231092] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"118.943119ms","start":"2026-07-06T23:14:38.094717Z","end":"2026-07-06T23:14:38.21366Z","steps":["trace[1591231092] 'process raft request' (duration: 84.361572ms)","trace[1591231092] 'compare' (duration: 34.411624ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:38.21377Z","caller":"traceutil/trace.go:171","msg":"trace[169874363] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"117.44564ms","start":"2026-07-06T23:14:38.0963Z","end":"2026-07-06T23:14:38.213745Z","steps":["trace[169874363] 'process raft request' (duration: 117.389618ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:38.21383Z","caller":"traceutil/trace.go:171","msg":"trace[872799456] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"117.8975ms","start":"2026-07-06T23:14:38.095887Z","end":"2026-07-06T23:14:38.213784Z","steps":["trace[872799456] 'process raft request' (duration: 117.754456ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:38.265728Z","caller":"traceutil/trace.go:171","msg":"trace[344898108] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"141.999455ms","start":"2026-07-06T23:14:38.123709Z","end":"2026-07-06T23:14:38.265708Z","steps":["trace[344898108] 'process raft request' (duration: 141.822832ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:38.266262Z","caller":"traceutil/trace.go:171","msg":"trace[1763341821] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"141.239761ms","start":"2026-07-06T23:14:38.125011Z","end":"2026-07-06T23:14:38.266251Z","steps":["trace[1763341821] 'process raft request' (duration: 140.646918ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:38.266441Z","caller":"traceutil/trace.go:171","msg":"trace[1250596159] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"136.279291ms","start":"2026-07-06T23:14:38.130148Z","end":"2026-07-06T23:14:38.266427Z","steps":["trace[1250596159] 'process raft request' (duration: 136.051447ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:38.267042Z","caller":"traceutil/trace.go:171","msg":"trace[972335405] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"129.194248ms","start":"2026-07-06T23:14:38.137812Z","end":"2026-07-06T23:14:38.267006Z","steps":["trace[972335405] 'process raft request' (duration: 128.801359ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:38.444033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.477877ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-06T23:14:38.444282Z","caller":"traceutil/trace.go:171","msg":"trace[1372780952] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"148.476445ms","start":"2026-07-06T23:14:38.295787Z","end":"2026-07-06T23:14:38.444263Z","steps":["trace[1372780952] 'process raft request' (duration: 148.411774ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:38.444266Z","caller":"traceutil/trace.go:171","msg":"trace[1820767624] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"159.956957ms","start":"2026-07-06T23:14:38.284287Z","end":"2026-07-06T23:14:38.444244Z","steps":["trace[1820767624] 'process raft request' (duration: 58.118072ms)","trace[1820767624] 'compare' (duration: 101.374545ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:38.444509Z","caller":"traceutil/trace.go:171","msg":"trace[1185012967] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"158.070508ms","start":"2026-07-06T23:14:38.286428Z","end":"2026-07-06T23:14:38.444498Z","steps":["trace[1185012967] 'process raft request' (duration: 157.692311ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:38.444675Z","caller":"traceutil/trace.go:171","msg":"trace[1353500268] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:488; }","duration":"160.057358ms","start":"2026-07-06T23:14:38.284602Z","end":"2026-07-06T23:14:38.444659Z","steps":["trace[1353500268] 'read index received' (duration: 3.738236ms)","trace[1353500268] 'applied index is now lower than readState.Index' (duration: 156.318422ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:14:38.445013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.478758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"info","ts":"2026-07-06T23:14:38.445145Z","caller":"traceutil/trace.go:171","msg":"trace[235584060] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:474; }","duration":"165.604451ms","start":"2026-07-06T23:14:38.279475Z","end":"2026-07-06T23:14:38.44508Z","steps":["trace[235584060] 'agreement among raft nodes before linearized reading' (duration: 165.261245ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:38.588434Z","caller":"traceutil/trace.go:171","msg":"trace[891015710] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"131.83ms","start":"2026-07-06T23:14:38.456571Z","end":"2026-07-06T23:14:38.588401Z","steps":["trace[891015710] 'process raft request' (duration: 118.079613ms)","trace[891015710] 'compare' (duration: 13.661275ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:38.774346Z","caller":"traceutil/trace.go:171","msg":"trace[1415581930] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"183.686335ms","start":"2026-07-06T23:14:38.590629Z","end":"2026-07-06T23:14:38.774315Z","steps":["trace[1415581930] 'process raft request' (duration: 183.647374ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:38.774412Z","caller":"traceutil/trace.go:171","msg":"trace[493012654] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:492; }","duration":"317.210029ms","start":"2026-07-06T23:14:38.457172Z","end":"2026-07-06T23:14:38.774382Z","steps":["trace[493012654] 'read index received' (duration: 117.490461ms)","trace[493012654] 'applied index is now lower than readState.Index' (duration: 199.717308ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:38.774403Z","caller":"traceutil/trace.go:171","msg":"trace[664204095] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"317.736239ms","start":"2026-07-06T23:14:38.456637Z","end":"2026-07-06T23:14:38.774373Z","steps":["trace[664204095] 'process raft request' (duration: 243.92967ms)","trace[664204095] 'compare' (duration: 73.607195ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:14:38.774648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.463419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-07-06T23:14:38.774701Z","caller":"traceutil/trace.go:171","msg":"trace[330806600] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:477; }","duration":"286.564562ms","start":"2026-07-06T23:14:38.488126Z","end":"2026-07-06T23:14:38.774691Z","steps":["trace[330806600] 'agreement among raft nodes before linearized reading' (duration: 286.478571ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:38.774683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:38.456616Z","time spent":"317.964355ms","remote":"127.0.0.1:51770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4656,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T23:14:38.77477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.975401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-779fd\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-07-06T23:14:38.774804Z","caller":"traceutil/trace.go:171","msg":"trace[227650044] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-779fd; range_end:; response_count:1; response_revision:477; }","duration":"183.020922ms","start":"2026-07-06T23:14:38.591775Z","end":"2026-07-06T23:14:38.774796Z","steps":["trace[227650044] 'agreement among raft nodes before linearized reading' (duration: 182.942991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:38.774695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.495376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"info","ts":"2026-07-06T23:14:38.774939Z","caller":"traceutil/trace.go:171","msg":"trace[117109315] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:477; }","duration":"317.784741ms","start":"2026-07-06T23:14:38.457145Z","end":"2026-07-06T23:14:38.77493Z","steps":["trace[117109315] 'agreement among raft nodes before linearized reading' (duration: 317.381943ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:38.774991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:38.457137Z","time spent":"317.842593ms","remote":"127.0.0.1:51792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":14485,"request content":"key:\"/registry/daemonsets/kube-system/cilium\" "} {"level":"warn","ts":"2026-07-06T23:14:38.775094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.423395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-07-06T23:14:38.775144Z","caller":"traceutil/trace.go:171","msg":"trace[276377636] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:477; }","duration":"211.492596ms","start":"2026-07-06T23:14:38.563635Z","end":"2026-07-06T23:14:38.775127Z","steps":["trace[276377636] 'agreement among raft nodes before linearized reading' (duration: 211.106539ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:40.90379Z","caller":"traceutil/trace.go:171","msg":"trace[1474953461] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"634.045612ms","start":"2026-07-06T23:14:40.26971Z","end":"2026-07-06T23:14:40.903755Z","steps":["trace[1474953461] 'process raft request' (duration: 622.779715ms)","trace[1474953461] 'compare' (duration: 10.874129ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:40.903861Z","caller":"traceutil/trace.go:171","msg":"trace[1924750991] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"633.697914ms","start":"2026-07-06T23:14:40.27014Z","end":"2026-07-06T23:14:40.903838Z","steps":["trace[1924750991] 'process raft request' (duration: 633.570302ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:40.904208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:40.270113Z","time spent":"634.041162ms","remote":"127.0.0.1:51418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-06T23:14:40.904019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:40.269691Z","time spent":"634.223576ms","remote":"127.0.0.1:51418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:14:40.904459Z","caller":"traceutil/trace.go:171","msg":"trace[1869644046] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"633.280567ms","start":"2026-07-06T23:14:40.271167Z","end":"2026-07-06T23:14:40.904448Z","steps":["trace[1869644046] 'process raft request' (duration: 632.642424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:40.904524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:40.271162Z","time spent":"633.327838ms","remote":"127.0.0.1:51418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:14:40.904571Z","caller":"traceutil/trace.go:171","msg":"trace[689182948] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"615.984918ms","start":"2026-07-06T23:14:40.288572Z","end":"2026-07-06T23:14:40.904557Z","steps":["trace[689182948] 'process raft request' (duration: 615.789664ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:40.904584Z","caller":"traceutil/trace.go:171","msg":"trace[1354751062] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"499.901296ms","start":"2026-07-06T23:14:40.404667Z","end":"2026-07-06T23:14:40.904568Z","steps":["trace[1354751062] 'process raft request' (duration: 499.798534ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:40.904643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.029633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-06T23:14:40.904645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:40.288554Z","time spent":"616.061419ms","remote":"127.0.0.1:51418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:14:40.904671Z","caller":"traceutil/trace.go:171","msg":"trace[1992197836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"301.098895ms","start":"2026-07-06T23:14:40.603563Z","end":"2026-07-06T23:14:40.904662Z","steps":["trace[1992197836] 'agreement among raft nodes before linearized reading' (duration: 301.030924ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:40.904576Z","caller":"traceutil/trace.go:171","msg":"trace[810397975] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:529; }","duration":"300.945742ms","start":"2026-07-06T23:14:40.60362Z","end":"2026-07-06T23:14:40.904566Z","steps":["trace[810397975] 'read index received' (duration: 288.875599ms)","trace[810397975] 'applied index is now lower than readState.Index' (duration: 12.019492ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:14:40.90469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:40.603541Z","time spent":"301.145056ms","remote":"127.0.0.1:51392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-06T23:14:40.904659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:40.404641Z","time spent":"499.984207ms","remote":"127.0.0.1:51418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-06T23:14:45.177733Z","caller":"traceutil/trace.go:171","msg":"trace[253245824] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"116.667994ms","start":"2026-07-06T23:14:45.061034Z","end":"2026-07-06T23:14:45.177702Z","steps":["trace[253245824] 'process raft request' (duration: 87.396134ms)","trace[253245824] 'compare' (duration: 29.158258ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:45.225334Z","caller":"traceutil/trace.go:171","msg":"trace[1299630678] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"161.08591ms","start":"2026-07-06T23:14:45.064227Z","end":"2026-07-06T23:14:45.225313Z","steps":["trace[1299630678] 'process raft request' (duration: 160.898436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:45.398924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.300696ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-06T23:14:45.399171Z","caller":"traceutil/trace.go:171","msg":"trace[1334606109] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:599; }","duration":"166.076191ms","start":"2026-07-06T23:14:45.233073Z","end":"2026-07-06T23:14:45.399149Z","steps":["trace[1334606109] 'read index received' (duration: 49.462628ms)","trace[1334606109] 'applied index is now lower than readState.Index' (duration: 116.612453ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:14:45.399277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.196133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:14:45.399309Z","caller":"traceutil/trace.go:171","msg":"trace[688475393] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:579; }","duration":"166.251893ms","start":"2026-07-06T23:14:45.233044Z","end":"2026-07-06T23:14:45.399296Z","steps":["trace[688475393] 'agreement among raft nodes before linearized reading' (duration: 166.171082ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:45.399156Z","caller":"traceutil/trace.go:171","msg":"trace[506192223] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"169.488229ms","start":"2026-07-06T23:14:45.229637Z","end":"2026-07-06T23:14:45.399126Z","steps":["trace[506192223] 'process raft request' (duration: 52.888607ms)","trace[506192223] 'compare' (duration: 116.163343ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:45.399384Z","caller":"traceutil/trace.go:171","msg":"trace[1353788972] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"169.104822ms","start":"2026-07-06T23:14:45.230251Z","end":"2026-07-06T23:14:45.399355Z","steps":["trace[1353788972] 'process raft request' (duration: 168.799856ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:45.399597Z","caller":"traceutil/trace.go:171","msg":"trace[1547688201] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"140.869152ms","start":"2026-07-06T23:14:45.258715Z","end":"2026-07-06T23:14:45.399585Z","steps":["trace[1547688201] 'process raft request' (duration: 140.386912ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:47.34889Z","caller":"traceutil/trace.go:171","msg":"trace[1084243540] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"139.128697ms","start":"2026-07-06T23:14:47.209721Z","end":"2026-07-06T23:14:47.348849Z","steps":["trace[1084243540] 'process raft request' (duration: 138.28494ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:47.752082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.521966ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-06T23:14:47.752185Z","caller":"traceutil/trace.go:171","msg":"trace[1088524727] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"348.207164ms","start":"2026-07-06T23:14:47.403961Z","end":"2026-07-06T23:14:47.752168Z","steps":["trace[1088524727] 'read index received' (duration: 146.554296ms)","trace[1088524727] 'applied index is now lower than readState.Index' (duration: 201.651858ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:47.752237Z","caller":"traceutil/trace.go:171","msg":"trace[1044539598] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"474.973261ms","start":"2026-07-06T23:14:47.277201Z","end":"2026-07-06T23:14:47.752174Z","steps":["trace[1044539598] 'process raft request' (duration: 273.278332ms)","trace[1044539598] 'compare' (duration: 201.389823ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:14:47.752321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.363647ms","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-07-06T23:14:47.752372Z","caller":"traceutil/trace.go:171","msg":"trace[2116213873] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:592; }","duration":"348.456319ms","start":"2026-07-06T23:14:47.4039Z","end":"2026-07-06T23:14:47.752356Z","steps":["trace[2116213873] 'agreement among raft nodes before linearized reading' (duration: 348.320786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:47.752408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:47.403876Z","time spent":"348.52369ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-06T23:14:47.752415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:47.277181Z","time spent":"475.150395ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T23:14:48.799571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.108879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-06T23:14:48.799724Z","caller":"traceutil/trace.go:171","msg":"trace[481599708] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.395078095s","start":"2026-07-06T23:14:47.404617Z","end":"2026-07-06T23:14:48.799695Z","steps":["trace[481599708] 'process raft request' (duration: 496.737891ms)","trace[481599708] 'compare' (duration: 897.863635ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:48.799835Z","caller":"traceutil/trace.go:171","msg":"trace[1977699777] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"1.047600246s","start":"2026-07-06T23:14:47.752222Z","end":"2026-07-06T23:14:48.799822Z","steps":["trace[1977699777] 'read index received' (duration: 149.112888ms)","trace[1977699777] 'applied index is now lower than readState.Index' (duration: 898.485918ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:14:48.799884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:47.404572Z","time spent":"1.395226898s","remote":"127.0.0.1:51830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-06T23:14:48.799958Z","caller":"traceutil/trace.go:171","msg":"trace[1099538424] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.043000163s","start":"2026-07-06T23:14:47.756926Z","end":"2026-07-06T23:14:48.799926Z","steps":["trace[1099538424] 'process raft request' (duration: 1.042794668s)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:48.800069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.395588786s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-06T23:14:48.800079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.196679272s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-06T23:14:48.800131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:47.756906Z","time spent":"1.043134945s","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:14:48.800168Z","caller":"traceutil/trace.go:171","msg":"trace[538725386] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"1.196794645s","start":"2026-07-06T23:14:47.603345Z","end":"2026-07-06T23:14:48.800139Z","steps":["trace[538725386] 'agreement among raft nodes before linearized reading' (duration: 1.196686333s)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:48.800224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:47.603326Z","time spent":"1.196888606s","remote":"127.0.0.1:51392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-06T23:14:48.800218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.365363196s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sgxk4\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-06T23:14:48.800319Z","caller":"traceutil/trace.go:171","msg":"trace[1323111460] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sgxk4; range_end:; response_count:1; response_revision:595; }","duration":"1.365502958s","start":"2026-07-06T23:14:47.434792Z","end":"2026-07-06T23:14:48.800295Z","steps":["trace[1323111460] 'agreement among raft nodes before linearized reading' (duration: 1.365298394s)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:48.800372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:47.434781Z","time spent":"1.365581349s","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-sgxk4\" "} {"level":"info","ts":"2026-07-06T23:14:48.800114Z","caller":"traceutil/trace.go:171","msg":"trace[2037583252] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"1.395674267s","start":"2026-07-06T23:14:47.404431Z","end":"2026-07-06T23:14:48.800105Z","steps":["trace[2037583252] 'agreement among raft nodes before linearized reading' (duration: 1.395447953s)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:48.800496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:47.404408Z","time spent":"1.396078356s","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-06T23:14:49.10996Z","caller":"traceutil/trace.go:171","msg":"trace[1559762397] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"299.33399ms","start":"2026-07-06T23:14:48.810599Z","end":"2026-07-06T23:14:49.109933Z","steps":["trace[1559762397] 'read index received' (duration: 207.309932ms)","trace[1559762397] 'applied index is now lower than readState.Index' (duration: 92.022968ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:49.110059Z","caller":"traceutil/trace.go:171","msg":"trace[586740436] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"303.937982ms","start":"2026-07-06T23:14:48.806089Z","end":"2026-07-06T23:14:49.110027Z","steps":["trace[586740436] 'process raft request' (duration: 212.941846ms)","trace[586740436] 'compare' (duration: 90.788482ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:14:49.110428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:48.806059Z","time spent":"304.303929ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T23:14:49.110188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.566684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:14:49.11052Z","caller":"traceutil/trace.go:171","msg":"trace[1895798616] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:596; }","duration":"299.929651ms","start":"2026-07-06T23:14:48.810565Z","end":"2026-07-06T23:14:49.110495Z","steps":["trace[1895798616] 'agreement among raft nodes before linearized reading' (duration: 299.554324ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:49.110585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:48.810554Z","time spent":"300.002492ms","remote":"127.0.0.1:51578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-07-06T23:14:49.111006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.38848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:14:49.111004Z","caller":"traceutil/trace.go:171","msg":"trace[1167097153] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"294.190595ms","start":"2026-07-06T23:14:48.816787Z","end":"2026-07-06T23:14:49.110978Z","steps":["trace[1167097153] 'process raft request' (duration: 293.93257ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:49.111057Z","caller":"traceutil/trace.go:171","msg":"trace[1845835457] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"300.439181ms","start":"2026-07-06T23:14:48.810603Z","end":"2026-07-06T23:14:49.111042Z","steps":["trace[1845835457] 'agreement among raft nodes before linearized reading' (duration: 300.34634ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:49.111234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:48.810562Z","time spent":"300.658816ms","remote":"127.0.0.1:51392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-06T23:14:49.607312Z","caller":"traceutil/trace.go:171","msg":"trace[1782369570] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"139.887312ms","start":"2026-07-06T23:14:49.467403Z","end":"2026-07-06T23:14:49.60729Z","steps":["trace[1782369570] 'process raft request' (duration: 139.75472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:50.864404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.210141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:14:50.864504Z","caller":"traceutil/trace.go:171","msg":"trace[1660526826] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"264.371625ms","start":"2026-07-06T23:14:50.600107Z","end":"2026-07-06T23:14:50.864479Z","steps":["trace[1660526826] 'range keys from in-memory index tree' (duration: 264.10997ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:51.025574Z","caller":"traceutil/trace.go:171","msg":"trace[1488930883] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"220.886137ms","start":"2026-07-06T23:14:50.804659Z","end":"2026-07-06T23:14:51.025545Z","steps":["trace[1488930883] 'read index received' (duration: 220.798806ms)","trace[1488930883] 'applied index is now lower than readState.Index' (duration: 85.761µs)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:51.025701Z","caller":"traceutil/trace.go:171","msg":"trace[9621797] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"342.509871ms","start":"2026-07-06T23:14:50.683166Z","end":"2026-07-06T23:14:51.025676Z","steps":["trace[9621797] 'process raft request' (duration: 342.212695ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:51.025798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.120552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-06T23:14:51.025867Z","caller":"traceutil/trace.go:171","msg":"trace[1432546816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"221.247704ms","start":"2026-07-06T23:14:50.804601Z","end":"2026-07-06T23:14:51.025849Z","steps":["trace[1432546816] 'agreement among raft nodes before linearized reading' (duration: 221.074721ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:51.025858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:50.683144Z","time spent":"342.638733ms","remote":"127.0.0.1:51418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-06T23:14:51.088585Z","caller":"traceutil/trace.go:171","msg":"trace[1761289239] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"207.108029ms","start":"2026-07-06T23:14:50.881456Z","end":"2026-07-06T23:14:51.088564Z","steps":["trace[1761289239] 'process raft request' (duration: 206.842083ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:51.660766Z","caller":"traceutil/trace.go:171","msg":"trace[1832634654] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"179.034902ms","start":"2026-07-06T23:14:51.481697Z","end":"2026-07-06T23:14:51.660732Z","steps":["trace[1832634654] 'process raft request' (duration: 159.023218ms)","trace[1832634654] 'compare' (duration: 19.806261ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:14:51.787565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.90702ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-06T23:14:51.787776Z","caller":"traceutil/trace.go:171","msg":"trace[1185615499] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"121.479271ms","start":"2026-07-06T23:14:51.666281Z","end":"2026-07-06T23:14:51.78776Z","steps":["trace[1185615499] 'process raft request' (duration: 121.380988ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:51.787787Z","caller":"traceutil/trace.go:171","msg":"trace[70295918] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"250.539715ms","start":"2026-07-06T23:14:51.53722Z","end":"2026-07-06T23:14:51.78776Z","steps":["trace[70295918] 'read index received' (duration: 103.394345ms)","trace[70295918] 'applied index is now lower than readState.Index' (duration: 147.14349ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:14:51.788017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.772639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-779fd\" ","response":"range_response_count:1 size:4888"} {"level":"info","ts":"2026-07-06T23:14:51.788049Z","caller":"traceutil/trace.go:171","msg":"trace[755226913] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-779fd; range_end:; response_count:1; response_revision:645; }","duration":"250.85211ms","start":"2026-07-06T23:14:51.537191Z","end":"2026-07-06T23:14:51.788043Z","steps":["trace[755226913] 'agreement among raft nodes before linearized reading' (duration: 250.681997ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:52.004772Z","caller":"traceutil/trace.go:171","msg":"trace[1348492985] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"216.897696ms","start":"2026-07-06T23:14:51.787842Z","end":"2026-07-06T23:14:52.004739Z","steps":["trace[1348492985] 'read index received' (duration: 158.715702ms)","trace[1348492985] 'applied index is now lower than readState.Index' (duration: 58.180674ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:14:52.004926Z","caller":"traceutil/trace.go:171","msg":"trace[2126507350] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"319.691701ms","start":"2026-07-06T23:14:51.685205Z","end":"2026-07-06T23:14:52.004896Z","steps":["trace[2126507350] 'process raft request' (duration: 261.405094ms)","trace[2126507350] 'compare' (duration: 57.861068ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:14:52.00508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:51.685178Z","time spent":"319.829103ms","remote":"127.0.0.1:51418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-06T23:14:52.00544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.607401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-06T23:14:52.005429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.711746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-06T23:14:52.005509Z","caller":"traceutil/trace.go:171","msg":"trace[357228223] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"399.730965ms","start":"2026-07-06T23:14:51.605762Z","end":"2026-07-06T23:14:52.005493Z","steps":["trace[357228223] 'agreement among raft nodes before linearized reading' (duration: 399.100362ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:14:52.005553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:14:51.60574Z","time spent":"399.803576ms","remote":"127.0.0.1:51392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-06T23:14:52.005554Z","caller":"traceutil/trace.go:171","msg":"trace[1563730672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"236.846489ms","start":"2026-07-06T23:14:51.768663Z","end":"2026-07-06T23:14:52.005509Z","steps":["trace[1563730672] 'agreement among raft nodes before linearized reading' (duration: 236.42814ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:52.011377Z","caller":"traceutil/trace.go:171","msg":"trace[158524521] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"217.16687ms","start":"2026-07-06T23:14:51.794181Z","end":"2026-07-06T23:14:52.011347Z","steps":["trace[158524521] 'process raft request' (duration: 216.935246ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:52.011528Z","caller":"traceutil/trace.go:171","msg":"trace[947440321] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"128.896281ms","start":"2026-07-06T23:14:51.882616Z","end":"2026-07-06T23:14:52.011512Z","steps":["trace[947440321] 'process raft request' (duration: 128.679496ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:14:52.011393Z","caller":"traceutil/trace.go:171","msg":"trace[584865797] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"216.661352ms","start":"2026-07-06T23:14:51.794701Z","end":"2026-07-06T23:14:52.011362Z","steps":["trace[584865797] 'process raft request' (duration: 216.535899ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:15:04.292957Z","caller":"traceutil/trace.go:171","msg":"trace[259590448] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"155.984947ms","start":"2026-07-06T23:15:04.136932Z","end":"2026-07-06T23:15:04.292917Z","steps":["trace[259590448] 'process raft request' (duration: 155.715401ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:15:06.739061Z","caller":"traceutil/trace.go:171","msg":"trace[389768088] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"108.623181ms","start":"2026-07-06T23:15:06.630418Z","end":"2026-07-06T23:15:06.739041Z","steps":["trace[389768088] 'process raft request' (duration: 108.509269ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:15:37.790748Z","caller":"traceutil/trace.go:171","msg":"trace[826888219] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1005; }","duration":"327.133306ms","start":"2026-07-06T23:15:37.463586Z","end":"2026-07-06T23:15:37.79072Z","steps":["trace[826888219] 'read index received' (duration: 326.80898ms)","trace[826888219] 'applied index is now lower than readState.Index' (duration: 323.136µs)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:15:37.790856Z","caller":"traceutil/trace.go:171","msg":"trace[760230234] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"462.735841ms","start":"2026-07-06T23:15:37.328097Z","end":"2026-07-06T23:15:37.790833Z","steps":["trace[760230234] 'process raft request' (duration: 462.456206ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:15:37.790996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:15:37.32807Z","time spent":"462.858042ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T23:15:37.791011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.975659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-06T23:15:37.791027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.437921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-06T23:15:37.79106Z","caller":"traceutil/trace.go:171","msg":"trace[1755524305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:968; }","duration":"310.07798ms","start":"2026-07-06T23:15:37.480966Z","end":"2026-07-06T23:15:37.791044Z","steps":["trace[1755524305] 'agreement among raft nodes before linearized reading' (duration: 309.908018ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:15:37.791091Z","caller":"traceutil/trace.go:171","msg":"trace[2086672379] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:968; }","duration":"327.546103ms","start":"2026-07-06T23:15:37.463529Z","end":"2026-07-06T23:15:37.791075Z","steps":["trace[2086672379] 'agreement among raft nodes before linearized reading' (duration: 327.33942ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:15:37.791106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:15:37.480947Z","time spent":"310.150672ms","remote":"127.0.0.1:51602","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-07-06T23:15:37.791128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:15:37.463504Z","time spent":"327.616693ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-06T23:15:38.992146Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971658462871346,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-06T23:15:39.233813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.973714ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-06T23:15:39.234118Z","caller":"traceutil/trace.go:171","msg":"trace[1779722940] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"1.439723272s","start":"2026-07-06T23:15:37.79436Z","end":"2026-07-06T23:15:39.234083Z","steps":["trace[1779722940] 'process raft request' (duration: 560.343111ms)","trace[1779722940] 'compare' (duration: 878.575387ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:15:39.23416Z","caller":"traceutil/trace.go:171","msg":"trace[1011320357] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1006; }","duration":"742.724888ms","start":"2026-07-06T23:15:38.491412Z","end":"2026-07-06T23:15:39.234137Z","steps":["trace[1011320357] 'read index received' (duration: 586.144632ms)","trace[1011320357] 'applied index is now lower than readState.Index' (duration: 156.579026ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:15:39.234277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:15:37.794298Z","time spent":"1.439902566s","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T23:15:39.234575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.141335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-06T23:15:39.234647Z","caller":"traceutil/trace.go:171","msg":"trace[947186086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:971; }","duration":"743.226926ms","start":"2026-07-06T23:15:38.491405Z","end":"2026-07-06T23:15:39.234632Z","steps":["trace[947186086] 'agreement among raft nodes before linearized reading' (duration: 743.010443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:15:39.234684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:15:38.491351Z","time spent":"743.326689ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-06T23:15:39.234704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.617439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-06T23:15:39.234743Z","caller":"traceutil/trace.go:171","msg":"trace[298210518] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:971; }","duration":"398.67953ms","start":"2026-07-06T23:15:38.836051Z","end":"2026-07-06T23:15:39.23473Z","steps":["trace[298210518] 'agreement among raft nodes before linearized reading' (duration: 398.562978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:15:39.234774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:15:38.836034Z","time spent":"398.732991ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-06T23:15:39.23496Z","caller":"traceutil/trace.go:171","msg":"trace[68360588] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"1.439228134s","start":"2026-07-06T23:15:37.795718Z","end":"2026-07-06T23:15:39.234946Z","steps":["trace[68360588] 'process raft request' (duration: 1.438256127s)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:15:39.235031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:15:37.795695Z","time spent":"1.439289586s","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:15:39.235113Z","caller":"traceutil/trace.go:171","msg":"trace[2002583012] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"937.118226ms","start":"2026-07-06T23:15:38.297988Z","end":"2026-07-06T23:15:39.235106Z","steps":["trace[2002583012] 'process raft request' (duration: 936.092959ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:15:39.235163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:15:38.297949Z","time spent":"937.182848ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T23:15:39.234593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.844158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:15:39.235282Z","caller":"traceutil/trace.go:171","msg":"trace[2140378961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:971; }","duration":"634.53485ms","start":"2026-07-06T23:15:38.600694Z","end":"2026-07-06T23:15:39.235229Z","steps":["trace[2140378961] 'agreement among raft nodes before linearized reading' (duration: 633.867459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:15:39.235378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:15:38.60067Z","time spent":"634.676642ms","remote":"127.0.0.1:51392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-06T23:15:39.439007Z","caller":"traceutil/trace.go:171","msg":"trace[746702906] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"198.379744ms","start":"2026-07-06T23:15:39.240608Z","end":"2026-07-06T23:15:39.438988Z","steps":["trace[746702906] 'process raft request' (duration: 198.342943ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:15:39.43921Z","caller":"traceutil/trace.go:171","msg":"trace[2146922898] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"198.855622ms","start":"2026-07-06T23:15:39.240286Z","end":"2026-07-06T23:15:39.439142Z","steps":["trace[2146922898] 'process raft request' (duration: 180.445245ms)","trace[2146922898] 'compare' (duration: 18.110432ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:15:41.362139Z","caller":"traceutil/trace.go:171","msg":"trace[995891544] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"120.658676ms","start":"2026-07-06T23:15:41.24145Z","end":"2026-07-06T23:15:41.362108Z","steps":["trace[995891544] 'process raft request' (duration: 120.478703ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:15:41.362383Z","caller":"traceutil/trace.go:171","msg":"trace[1545829137] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"119.856152ms","start":"2026-07-06T23:15:41.242501Z","end":"2026-07-06T23:15:41.362357Z","steps":["trace[1545829137] 'process raft request' (duration: 119.545087ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:15:55.534878Z","caller":"traceutil/trace.go:171","msg":"trace[907460532] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"111.999851ms","start":"2026-07-06T23:15:55.422853Z","end":"2026-07-06T23:15:55.534853Z","steps":["trace[907460532] 'process raft request' (duration: 111.9096ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:15:55.559025Z","caller":"traceutil/trace.go:171","msg":"trace[2145825438] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"135.374022ms","start":"2026-07-06T23:15:55.423626Z","end":"2026-07-06T23:15:55.559Z","steps":["trace[2145825438] 'process raft request' (duration: 135.22205ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:07.688051Z","caller":"traceutil/trace.go:171","msg":"trace[417758026] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"270.689982ms","start":"2026-07-06T23:16:07.417319Z","end":"2026-07-06T23:16:07.688009Z","steps":["trace[417758026] 'process raft request' (duration: 269.831148ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:09.899637Z","caller":"traceutil/trace.go:171","msg":"trace[406036959] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"114.785108ms","start":"2026-07-06T23:16:09.784832Z","end":"2026-07-06T23:16:09.899617Z","steps":["trace[406036959] 'process raft request' (duration: 114.634086ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:09.899847Z","caller":"traceutil/trace.go:171","msg":"trace[449797117] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"114.633545ms","start":"2026-07-06T23:16:09.785201Z","end":"2026-07-06T23:16:09.899835Z","steps":["trace[449797117] 'process raft request' (duration: 114.380311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:12.755515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.021598ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-06T23:16:12.756683Z","caller":"traceutil/trace.go:171","msg":"trace[592719368] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1118; }","duration":"972.01518ms","start":"2026-07-06T23:16:11.784643Z","end":"2026-07-06T23:16:12.756658Z","steps":["trace[592719368] 'read index received' (duration: 289.982476ms)","trace[592719368] 'applied index is now lower than readState.Index' (duration: 682.031424ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:16:12.756923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.259964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-06T23:16:12.756962Z","caller":"traceutil/trace.go:171","msg":"trace[1260895420] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1075; }","duration":"972.345684ms","start":"2026-07-06T23:16:11.784608Z","end":"2026-07-06T23:16:12.756953Z","steps":["trace[1260895420] 'agreement among raft nodes before linearized reading' (duration: 972.184352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:12.756995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:11.784593Z","time spent":"972.393826ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-06T23:16:12.757061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.629674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-06T23:16:12.757083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.315683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-06T23:16:12.757134Z","caller":"traceutil/trace.go:171","msg":"trace[1138091287] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"1.027265572s","start":"2026-07-06T23:16:11.729462Z","end":"2026-07-06T23:16:12.756728Z","steps":["trace[1138091287] 'process raft request' (duration: 1.026990337s)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:12.757138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.365534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-06T23:16:12.757251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.641028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-06T23:16:12.757257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:11.729439Z","time spent":"1.027751341s","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:16:12.757183Z","caller":"traceutil/trace.go:171","msg":"trace[115318457] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1075; }","duration":"854.449245ms","start":"2026-07-06T23:16:11.902711Z","end":"2026-07-06T23:16:12.757161Z","steps":["trace[115318457] 'agreement among raft nodes before linearized reading' (duration: 854.188081ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:12.7573Z","caller":"traceutil/trace.go:171","msg":"trace[677351708] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1075; }","duration":"153.705099ms","start":"2026-07-06T23:16:12.603582Z","end":"2026-07-06T23:16:12.757287Z","steps":["trace[677351708] 'agreement among raft nodes before linearized reading' (duration: 153.635688ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:12.757319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.159795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-06T23:16:12.757273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.24979ms","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-07-06T23:16:12.757323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:11.902694Z","time spent":"854.616248ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-06T23:16:12.757354Z","caller":"traceutil/trace.go:171","msg":"trace[554640452] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1075; }","duration":"206.237256ms","start":"2026-07-06T23:16:12.551107Z","end":"2026-07-06T23:16:12.757344Z","steps":["trace[554640452] 'agreement among raft nodes before linearized reading' (duration: 206.172365ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:12.757265Z","caller":"traceutil/trace.go:171","msg":"trace[1953645737] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1075; }","duration":"693.515127ms","start":"2026-07-06T23:16:12.063708Z","end":"2026-07-06T23:16:12.757224Z","steps":["trace[1953645737] 'agreement among raft nodes before linearized reading' (duration: 693.219201ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:12.757375Z","caller":"traceutil/trace.go:171","msg":"trace[30035088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1075; }","duration":"873.387232ms","start":"2026-07-06T23:16:11.88398Z","end":"2026-07-06T23:16:12.757368Z","steps":["trace[30035088] 'agreement among raft nodes before linearized reading' (duration: 873.154427ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:12.757429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:12.06369Z","time spent":"693.72955ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-06T23:16:12.757447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:11.883959Z","time spent":"873.479384ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-06T23:16:12.757114Z","caller":"traceutil/trace.go:171","msg":"trace[241205528] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1075; }","duration":"922.816268ms","start":"2026-07-06T23:16:11.834284Z","end":"2026-07-06T23:16:12.757101Z","steps":["trace[241205528] 'agreement among raft nodes before linearized reading' (duration: 922.608065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:12.7576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:11.834275Z","time spent":"923.286496ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-07-06T23:16:12.758774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.482672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-06T23:16:12.758858Z","caller":"traceutil/trace.go:171","msg":"trace[913907944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1075; }","duration":"855.602304ms","start":"2026-07-06T23:16:11.903227Z","end":"2026-07-06T23:16:12.75883Z","steps":["trace[913907944] 'agreement among raft nodes before linearized reading' (duration: 853.717332ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:12.758918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:11.903205Z","time spent":"855.697365ms","remote":"127.0.0.1:51602","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-07-06T23:16:12.955609Z","caller":"traceutil/trace.go:171","msg":"trace[1459981340] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"193.910449ms","start":"2026-07-06T23:16:12.761676Z","end":"2026-07-06T23:16:12.955586Z","steps":["trace[1459981340] 'process raft request' (duration: 193.753737ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:12.973479Z","caller":"traceutil/trace.go:171","msg":"trace[1269600496] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"211.399702ms","start":"2026-07-06T23:16:12.762062Z","end":"2026-07-06T23:16:12.973462Z","steps":["trace[1269600496] 'process raft request' (duration: 211.354941ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:12.97351Z","caller":"traceutil/trace.go:171","msg":"trace[1442379049] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"211.435272ms","start":"2026-07-06T23:16:12.762047Z","end":"2026-07-06T23:16:12.973483Z","steps":["trace[1442379049] 'process raft request' (duration: 211.30197ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:12.973667Z","caller":"traceutil/trace.go:171","msg":"trace[322012258] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"211.524884ms","start":"2026-07-06T23:16:12.76213Z","end":"2026-07-06T23:16:12.973655Z","steps":["trace[322012258] 'process raft request' (duration: 211.31209ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:12.973748Z","caller":"traceutil/trace.go:171","msg":"trace[827275731] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"211.502723ms","start":"2026-07-06T23:16:12.762234Z","end":"2026-07-06T23:16:12.973737Z","steps":["trace[827275731] 'process raft request' (duration: 211.377971ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:29.212451Z","caller":"traceutil/trace.go:171","msg":"trace[1058537551] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"397.165952ms","start":"2026-07-06T23:16:28.815256Z","end":"2026-07-06T23:16:29.212422Z","steps":["trace[1058537551] 'process raft request' (duration: 396.804524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:29.212609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:28.815231Z","time spent":"397.301735ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:16:40.756435Z","caller":"traceutil/trace.go:171","msg":"trace[779315470] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"106.366949ms","start":"2026-07-06T23:16:40.65005Z","end":"2026-07-06T23:16:40.756417Z","steps":["trace[779315470] 'process raft request' (duration: 106.253937ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:41.447924Z","caller":"traceutil/trace.go:171","msg":"trace[958863727] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"116.381608ms","start":"2026-07-06T23:16:41.331524Z","end":"2026-07-06T23:16:41.447905Z","steps":["trace[958863727] 'process raft request' (duration: 116.358808ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:41.448022Z","caller":"traceutil/trace.go:171","msg":"trace[1902601688] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"120.927193ms","start":"2026-07-06T23:16:41.327037Z","end":"2026-07-06T23:16:41.447964Z","steps":["trace[1902601688] 'process raft request' (duration: 114.873237ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:41.448174Z","caller":"traceutil/trace.go:171","msg":"trace[2103722487] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"120.159216ms","start":"2026-07-06T23:16:41.327961Z","end":"2026-07-06T23:16:41.44812Z","steps":["trace[2103722487] 'process raft request' (duration: 119.898541ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:41.448219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.059185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:16:41.448071Z","caller":"traceutil/trace.go:171","msg":"trace[226392681] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1272; }","duration":"120.895412ms","start":"2026-07-06T23:16:41.327148Z","end":"2026-07-06T23:16:41.448044Z","steps":["trace[226392681] 'read index received' (duration: 114.805455ms)","trace[226392681] 'applied index is now lower than readState.Index' (duration: 6.086667ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:16:41.448305Z","caller":"traceutil/trace.go:171","msg":"trace[1281583710] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1223; }","duration":"121.192609ms","start":"2026-07-06T23:16:41.327094Z","end":"2026-07-06T23:16:41.448287Z","steps":["trace[1281583710] 'agreement among raft nodes before linearized reading' (duration: 121.021114ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:41.448604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.614945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-06T23:16:41.448646Z","caller":"traceutil/trace.go:171","msg":"trace[1126666044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1223; }","duration":"120.695057ms","start":"2026-07-06T23:16:41.327938Z","end":"2026-07-06T23:16:41.448633Z","steps":["trace[1126666044] 'agreement among raft nodes before linearized reading' (duration: 120.503014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:41.44887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.657763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-06T23:16:41.448959Z","caller":"traceutil/trace.go:171","msg":"trace[1931908569] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1223; }","duration":"115.799385ms","start":"2026-07-06T23:16:41.333138Z","end":"2026-07-06T23:16:41.448937Z","steps":["trace[1931908569] 'agreement among raft nodes before linearized reading' (duration: 115.5165ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:43.571943Z","caller":"traceutil/trace.go:171","msg":"trace[657461640] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"115.287546ms","start":"2026-07-06T23:16:43.456637Z","end":"2026-07-06T23:16:43.571925Z","steps":["trace[657461640] 'process raft request' (duration: 115.074772ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:43.605007Z","caller":"traceutil/trace.go:171","msg":"trace[2090377650] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1287; }","duration":"135.650329ms","start":"2026-07-06T23:16:43.469331Z","end":"2026-07-06T23:16:43.604982Z","steps":["trace[2090377650] 'read index received' (duration: 102.413559ms)","trace[2090377650] 'applied index is now lower than readState.Index' (duration: 33.23509ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:16:43.605145Z","caller":"traceutil/trace.go:171","msg":"trace[694040001] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"147.501034ms","start":"2026-07-06T23:16:43.457611Z","end":"2026-07-06T23:16:43.605112Z","steps":["trace[694040001] 'process raft request' (duration: 147.153488ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:43.605222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.878323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-06T23:16:43.605255Z","caller":"traceutil/trace.go:171","msg":"trace[843996706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1237; }","duration":"135.936154ms","start":"2026-07-06T23:16:43.469311Z","end":"2026-07-06T23:16:43.605247Z","steps":["trace[843996706] 'agreement among raft nodes before linearized reading' (duration: 135.841182ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:43.605308Z","caller":"traceutil/trace.go:171","msg":"trace[989426470] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"147.030505ms","start":"2026-07-06T23:16:43.458272Z","end":"2026-07-06T23:16:43.605302Z","steps":["trace[989426470] 'process raft request' (duration: 146.651837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:43.605378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.695919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-06T23:16:43.605397Z","caller":"traceutil/trace.go:171","msg":"trace[740154544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1237; }","duration":"135.727501ms","start":"2026-07-06T23:16:43.469664Z","end":"2026-07-06T23:16:43.605392Z","steps":["trace[740154544] 'agreement among raft nodes before linearized reading' (duration: 135.68514ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:45.452708Z","caller":"traceutil/trace.go:171","msg":"trace[2042656051] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"116.289646ms","start":"2026-07-06T23:16:45.336394Z","end":"2026-07-06T23:16:45.452684Z","steps":["trace[2042656051] 'process raft request' (duration: 116.095833ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:45.693324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.721486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-06T23:16:45.693401Z","caller":"traceutil/trace.go:171","msg":"trace[370258590] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1240; }","duration":"117.866179ms","start":"2026-07-06T23:16:45.575517Z","end":"2026-07-06T23:16:45.693383Z","steps":["trace[370258590] 'range keys from in-memory index tree' (duration: 117.488132ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:45.87463Z","caller":"traceutil/trace.go:171","msg":"trace[229894147] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"163.042647ms","start":"2026-07-06T23:16:45.711561Z","end":"2026-07-06T23:16:45.874604Z","steps":["trace[229894147] 'process raft request' (duration: 162.864594ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:45.87986Z","caller":"traceutil/trace.go:171","msg":"trace[1207015549] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"168.121643ms","start":"2026-07-06T23:16:45.711711Z","end":"2026-07-06T23:16:45.879833Z","steps":["trace[1207015549] 'process raft request' (duration: 167.96745ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:45.880138Z","caller":"traceutil/trace.go:171","msg":"trace[2033390060] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"168.361038ms","start":"2026-07-06T23:16:45.711765Z","end":"2026-07-06T23:16:45.880126Z","steps":["trace[2033390060] 'process raft request' (duration: 168.030951ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:45.880369Z","caller":"traceutil/trace.go:171","msg":"trace[746940007] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"168.539862ms","start":"2026-07-06T23:16:45.711795Z","end":"2026-07-06T23:16:45.880335Z","steps":["trace[746940007] 'process raft request' (duration: 168.458161ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:45.880434Z","caller":"traceutil/trace.go:171","msg":"trace[1258931400] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"168.665205ms","start":"2026-07-06T23:16:45.711755Z","end":"2026-07-06T23:16:45.88042Z","steps":["trace[1258931400] 'process raft request' (duration: 168.313598ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:47.599451Z","caller":"traceutil/trace.go:171","msg":"trace[921528671] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"703.208181ms","start":"2026-07-06T23:16:46.896219Z","end":"2026-07-06T23:16:47.599427Z","steps":["trace[921528671] 'process raft request' (duration: 703.012237ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:47.59968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:46.896206Z","time spent":"703.384385ms","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11375,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:16:47.859256Z","caller":"traceutil/trace.go:171","msg":"trace[1594577903] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"400.863289ms","start":"2026-07-06T23:16:47.458368Z","end":"2026-07-06T23:16:47.859232Z","steps":["trace[1594577903] 'process raft request' (duration: 400.742567ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:47.85938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:47.458351Z","time spent":"400.965111ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:16:47.859624Z","caller":"traceutil/trace.go:171","msg":"trace[1230476970] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1310; }","duration":"256.924068ms","start":"2026-07-06T23:16:47.602691Z","end":"2026-07-06T23:16:47.859615Z","steps":["trace[1230476970] 'read index received' (duration: 256.916298ms)","trace[1230476970] 'applied index is now lower than readState.Index' (duration: 7.22µs)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:16:47.859671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.98528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:16:47.859689Z","caller":"traceutil/trace.go:171","msg":"trace[1387080302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1256; }","duration":"257.03552ms","start":"2026-07-06T23:16:47.602649Z","end":"2026-07-06T23:16:47.859684Z","steps":["trace[1387080302] 'agreement among raft nodes before linearized reading' (duration: 257.000179ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:47.905883Z","caller":"traceutil/trace.go:171","msg":"trace[1437854626] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"301.730999ms","start":"2026-07-06T23:16:47.604134Z","end":"2026-07-06T23:16:47.905865Z","steps":["trace[1437854626] 'process raft request' (duration: 301.548645ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:47.90603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:47.604122Z","time spent":"301.830933ms","remote":"127.0.0.1:51514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":915,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:16:47.906102Z","caller":"traceutil/trace.go:171","msg":"trace[1110970750] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"299.564524ms","start":"2026-07-06T23:16:47.606513Z","end":"2026-07-06T23:16:47.906078Z","steps":["trace[1110970750] 'process raft request' (duration: 299.289508ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:47.906728Z","caller":"traceutil/trace.go:171","msg":"trace[1303801864] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"296.915379ms","start":"2026-07-06T23:16:47.609804Z","end":"2026-07-06T23:16:47.906719Z","steps":["trace[1303801864] 'process raft request' (duration: 296.03185ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:47.906882Z","caller":"traceutil/trace.go:171","msg":"trace[675014600] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"172.022784ms","start":"2026-07-06T23:16:47.734854Z","end":"2026-07-06T23:16:47.906877Z","steps":["trace[675014600] 'process raft request' (duration: 171.671807ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:50.469533Z","caller":"traceutil/trace.go:171","msg":"trace[219172847] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"457.174218ms","start":"2026-07-06T23:16:50.01234Z","end":"2026-07-06T23:16:50.469515Z","steps":["trace[219172847] 'process raft request' (duration: 456.819462ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:50.469679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:50.012321Z","time spent":"457.269031ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:16:50.474526Z","caller":"traceutil/trace.go:171","msg":"trace[1281845841] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1324; }","duration":"377.645366ms","start":"2026-07-06T23:16:50.096857Z","end":"2026-07-06T23:16:50.474503Z","steps":["trace[1281845841] 'read index received' (duration: 372.465069ms)","trace[1281845841] 'applied index is now lower than readState.Index' (duration: 5.179097ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:16:50.474792Z","caller":"traceutil/trace.go:171","msg":"trace[577802636] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"437.359577ms","start":"2026-07-06T23:16:50.03742Z","end":"2026-07-06T23:16:50.474779Z","steps":["trace[577802636] 'process raft request' (duration: 436.754154ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:50.474901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:50.037404Z","time spent":"437.428158ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:16:50.475077Z","caller":"traceutil/trace.go:171","msg":"trace[361348354] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"437.578922ms","start":"2026-07-06T23:16:50.037487Z","end":"2026-07-06T23:16:50.475066Z","steps":["trace[361348354] 'process raft request' (duration: 436.828116ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:50.475155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:50.037482Z","time spent":"437.641963ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T23:16:50.475223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.360691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:16:50.475257Z","caller":"traceutil/trace.go:171","msg":"trace[657296100] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1273; }","duration":"378.434212ms","start":"2026-07-06T23:16:50.096813Z","end":"2026-07-06T23:16:50.475247Z","steps":["trace[657296100] 'agreement among raft nodes before linearized reading' (duration: 378.378851ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:50.475275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:50.096797Z","time spent":"378.474174ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-06T23:16:50.475341Z","caller":"traceutil/trace.go:171","msg":"trace[1467792337] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"437.798897ms","start":"2026-07-06T23:16:50.037535Z","end":"2026-07-06T23:16:50.475334Z","steps":["trace[1467792337] 'process raft request' (duration: 436.929128ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:50.475382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:16:50.03753Z","time spent":"437.823437ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T23:16:50.494882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.835186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:16:50.494954Z","caller":"traceutil/trace.go:171","msg":"trace[2122500131] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1274; }","duration":"203.956668ms","start":"2026-07-06T23:16:50.29098Z","end":"2026-07-06T23:16:50.494937Z","steps":["trace[2122500131] 'agreement among raft nodes before linearized reading' (duration: 203.828995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:50.495342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.890757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-06T23:16:50.495946Z","caller":"traceutil/trace.go:171","msg":"trace[51746188] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1274; }","duration":"270.52508ms","start":"2026-07-06T23:16:50.225402Z","end":"2026-07-06T23:16:50.495927Z","steps":["trace[51746188] 'agreement among raft nodes before linearized reading' (duration: 269.343336ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:50.679666Z","caller":"traceutil/trace.go:171","msg":"trace[1350985746] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"200.667018ms","start":"2026-07-06T23:16:50.478975Z","end":"2026-07-06T23:16:50.679642Z","steps":["trace[1350985746] 'process raft request' (duration: 200.535916ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:50.696964Z","caller":"traceutil/trace.go:171","msg":"trace[1164332197] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"199.001555ms","start":"2026-07-06T23:16:50.497938Z","end":"2026-07-06T23:16:50.69694Z","steps":["trace[1164332197] 'process raft request' (duration: 198.847032ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:58.153613Z","caller":"traceutil/trace.go:171","msg":"trace[383539892] linearizableReadLoop","detail":"{readStateIndex:1391; appliedIndex:1390; }","duration":"119.966962ms","start":"2026-07-06T23:16:58.033618Z","end":"2026-07-06T23:16:58.153585Z","steps":["trace[383539892] 'read index received' (duration: 119.779239ms)","trace[383539892] 'applied index is now lower than readState.Index' (duration: 186.543µs)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:16:58.153687Z","caller":"traceutil/trace.go:171","msg":"trace[1745937331] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"173.795781ms","start":"2026-07-06T23:16:57.979869Z","end":"2026-07-06T23:16:58.153665Z","steps":["trace[1745937331] 'process raft request' (duration: 173.551006ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:58.153864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.234637ms","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-07-06T23:16:58.153946Z","caller":"traceutil/trace.go:171","msg":"trace[1130313376] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1335; }","duration":"120.381121ms","start":"2026-07-06T23:16:58.033546Z","end":"2026-07-06T23:16:58.153927Z","steps":["trace[1130313376] 'agreement among raft nodes before linearized reading' (duration: 120.147196ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:16:58.91734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.747199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-06T23:16:58.917479Z","caller":"traceutil/trace.go:171","msg":"trace[626574047] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1342; }","duration":"211.941263ms","start":"2026-07-06T23:16:58.705522Z","end":"2026-07-06T23:16:58.917464Z","steps":["trace[626574047] 'range keys from in-memory index tree' (duration: 211.540475ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:16:59.796501Z","caller":"traceutil/trace.go:171","msg":"trace[1383169566] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"189.027308ms","start":"2026-07-06T23:16:59.60745Z","end":"2026-07-06T23:16:59.796477Z","steps":["trace[1383169566] 'process raft request' (duration: 188.879555ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:17:12.737121Z","caller":"traceutil/trace.go:171","msg":"trace[484147286] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"109.061646ms","start":"2026-07-06T23:17:12.628035Z","end":"2026-07-06T23:17:12.737096Z","steps":["trace[484147286] 'process raft request' (duration: 103.02747ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:17:12.737206Z","caller":"traceutil/trace.go:171","msg":"trace[399376369] linearizableReadLoop","detail":"{readStateIndex:1464; appliedIndex:1462; }","duration":"108.481794ms","start":"2026-07-06T23:17:12.628699Z","end":"2026-07-06T23:17:12.737181Z","steps":["trace[399376369] 'read index received' (duration: 42.153895ms)","trace[399376369] 'applied index is now lower than readState.Index' (duration: 66.326349ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:17:12.737259Z","caller":"traceutil/trace.go:171","msg":"trace[1184687537] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"108.497415ms","start":"2026-07-06T23:17:12.628746Z","end":"2026-07-06T23:17:12.737243Z","steps":["trace[1184687537] 'process raft request' (duration: 108.306381ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:17:12.737408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.681338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-06T23:17:12.737612Z","caller":"traceutil/trace.go:171","msg":"trace[309548669] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1406; }","duration":"108.930704ms","start":"2026-07-06T23:17:12.62867Z","end":"2026-07-06T23:17:12.737601Z","steps":["trace[309548669] 'agreement among raft nodes before linearized reading' (duration: 108.597126ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:17:32.591268Z","caller":"traceutil/trace.go:171","msg":"trace[698088678] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"160.739017ms","start":"2026-07-06T23:17:32.4305Z","end":"2026-07-06T23:17:32.591239Z","steps":["trace[698088678] 'process raft request' (duration: 96.247994ms)","trace[698088678] 'compare' (duration: 64.384581ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:18:48.701349Z","caller":"traceutil/trace.go:171","msg":"trace[1640282934] linearizableReadLoop","detail":"{readStateIndex:1920; appliedIndex:1919; }","duration":"100.087202ms","start":"2026-07-06T23:18:48.601242Z","end":"2026-07-06T23:18:48.701329Z","steps":["trace[1640282934] 'read index received' (duration: 99.997978ms)","trace[1640282934] 'applied index is now lower than readState.Index' (duration: 88.454µs)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:18:48.701416Z","caller":"traceutil/trace.go:171","msg":"trace[1367646128] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"114.28933ms","start":"2026-07-06T23:18:48.587096Z","end":"2026-07-06T23:18:48.701386Z","steps":["trace[1367646128] 'process raft request' (duration: 114.130134ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:18:48.701471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.220646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:18:48.701509Z","caller":"traceutil/trace.go:171","msg":"trace[1115733730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1842; }","duration":"100.299158ms","start":"2026-07-06T23:18:48.601204Z","end":"2026-07-06T23:18:48.701504Z","steps":["trace[1115733730] 'agreement among raft nodes before linearized reading' (duration: 100.216786ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:18:48.761409Z","caller":"traceutil/trace.go:171","msg":"trace[1071785314] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"108.62308ms","start":"2026-07-06T23:18:48.652754Z","end":"2026-07-06T23:18:48.761377Z","steps":["trace[1071785314] 'process raft request' (duration: 83.364205ms)","trace[1071785314] 'compare' (duration: 25.122001ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:18:55.464097Z","caller":"traceutil/trace.go:171","msg":"trace[714555988] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"125.45556ms","start":"2026-07-06T23:18:55.338619Z","end":"2026-07-06T23:18:55.464074Z","steps":["trace[714555988] 'process raft request' (duration: 125.335017ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:18:55.465163Z","caller":"traceutil/trace.go:171","msg":"trace[1104314711] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"126.134772ms","start":"2026-07-06T23:18:55.338993Z","end":"2026-07-06T23:18:55.465128Z","steps":["trace[1104314711] 'process raft request' (duration: 125.893294ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:19:33.91043Z","caller":"traceutil/trace.go:171","msg":"trace[1171697855] transaction","detail":"{read_only:false; response_revision:2048; number_of_response:1; }","duration":"553.234445ms","start":"2026-07-06T23:19:33.357176Z","end":"2026-07-06T23:19:33.910411Z","steps":["trace[1171697855] 'process raft request' (duration: 553.129597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:19:33.910551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:19:33.357151Z","time spent":"553.334462ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:19:34.412357Z","caller":"traceutil/trace.go:171","msg":"trace[156551897] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"489.352788ms","start":"2026-07-06T23:19:33.92298Z","end":"2026-07-06T23:19:34.412333Z","steps":["trace[156551897] 'process raft request' (duration: 489.103298ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:19:34.412501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:19:33.922969Z","time spent":"489.457586ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:19:34.416594Z","caller":"traceutil/trace.go:171","msg":"trace[637314827] transaction","detail":"{read_only:false; response_revision:2053; number_of_response:1; }","duration":"485.575499ms","start":"2026-07-06T23:19:33.930998Z","end":"2026-07-06T23:19:34.416573Z","steps":["trace[637314827] 'process raft request' (duration: 485.542746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:19:34.416727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:19:33.930994Z","time spent":"485.663696ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:19:34.417024Z","caller":"traceutil/trace.go:171","msg":"trace[301932843] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"486.066906ms","start":"2026-07-06T23:19:33.930949Z","end":"2026-07-06T23:19:34.417016Z","steps":["trace[301932843] 'process raft request' (duration: 485.422607ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:19:34.417066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:19:33.930936Z","time spent":"486.106639ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T23:19:34.417189Z","caller":"traceutil/trace.go:171","msg":"trace[1326049546] transaction","detail":"{read_only:false; response_revision:2052; number_of_response:1; }","duration":"486.196857ms","start":"2026-07-06T23:19:33.930983Z","end":"2026-07-06T23:19:34.417179Z","steps":["trace[1326049546] 'process raft request' (duration: 485.521145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:19:34.417246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T23:19:33.930973Z","time spent":"486.24386ms","remote":"127.0.0.1:51602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-06T23:20:49.262051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.197883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T23:20:49.262854Z","caller":"traceutil/trace.go:171","msg":"trace[2136821128] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2415; }","duration":"130.105218ms","start":"2026-07-06T23:20:49.132726Z","end":"2026-07-06T23:20:49.262832Z","steps":["trace[2136821128] 'count revisions from in-memory index tree' (duration: 129.093711ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:20:55.964834Z","caller":"traceutil/trace.go:171","msg":"trace[1234826978] transaction","detail":"{read_only:false; response_revision:2451; number_of_response:1; }","duration":"140.009006ms","start":"2026-07-06T23:20:55.824801Z","end":"2026-07-06T23:20:55.96481Z","steps":["trace[1234826978] 'process raft request' (duration: 139.876782ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:21:30.542758Z","caller":"traceutil/trace.go:171","msg":"trace[636846078] transaction","detail":"{read_only:false; response_revision:2617; number_of_response:1; }","duration":"138.773492ms","start":"2026-07-06T23:21:30.40394Z","end":"2026-07-06T23:21:30.542713Z","steps":["trace[636846078] 'process raft request' (duration: 138.505975ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:21:30.542735Z","caller":"traceutil/trace.go:171","msg":"trace[657416507] linearizableReadLoop","detail":"{readStateIndex:2728; appliedIndex:2727; }","duration":"128.246098ms","start":"2026-07-06T23:21:30.414427Z","end":"2026-07-06T23:21:30.542673Z","steps":["trace[657416507] 'read index received' (duration: 127.873038ms)","trace[657416507] 'applied index is now lower than readState.Index' (duration: 371.64µs)"],"step_count":2} {"level":"warn","ts":"2026-07-06T23:21:30.543101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-06T23:21:30.543165Z","caller":"traceutil/trace.go:171","msg":"trace[207492266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2617; }","duration":"128.813394ms","start":"2026-07-06T23:21:30.414335Z","end":"2026-07-06T23:21:30.543148Z","steps":["trace[207492266] 'agreement among raft nodes before linearized reading' (duration: 128.572567ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:21:30.543301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.315669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-06T23:21:30.543444Z","caller":"traceutil/trace.go:171","msg":"trace[626419486] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2617; }","duration":"125.502034ms","start":"2026-07-06T23:21:30.417904Z","end":"2026-07-06T23:21:30.543406Z","steps":["trace[626419486] 'agreement among raft nodes before linearized reading' (duration: 125.016721ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T23:21:30.680942Z","caller":"traceutil/trace.go:171","msg":"trace[685872540] transaction","detail":"{read_only:false; response_revision:2618; number_of_response:1; }","duration":"134.260702ms","start":"2026-07-06T23:21:30.546656Z","end":"2026-07-06T23:21:30.680916Z","steps":["trace[685872540] 'process raft request' (duration: 86.197862ms)","trace[685872540] 'compare' (duration: 47.890285ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:21:30.681039Z","caller":"traceutil/trace.go:171","msg":"trace[1082991722] linearizableReadLoop","detail":"{readStateIndex:2730; appliedIndex:2728; }","duration":"128.502935ms","start":"2026-07-06T23:21:30.552517Z","end":"2026-07-06T23:21:30.68102Z","steps":["trace[1082991722] 'read index received' (duration: 80.457546ms)","trace[1082991722] 'applied index is now lower than readState.Index' (duration: 48.043869ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T23:21:30.681135Z","caller":"traceutil/trace.go:171","msg":"trace[772815740] transaction","detail":"{read_only:false; response_revision:2619; number_of_response:1; }","duration":"133.689886ms","start":"2026-07-06T23:21:30.547434Z","end":"2026-07-06T23:21:30.681124Z","steps":["trace[772815740] 'process raft request' (duration: 133.437058ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T23:21:30.681774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.240025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-zsmjz\" ","response":"range_response_count:1 size:11390"} {"level":"info","ts":"2026-07-06T23:21:30.681858Z","caller":"traceutil/trace.go:171","msg":"trace[2095589713] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-zsmjz; range_end:; response_count:1; response_revision:2619; }","duration":"129.350519ms","start":"2026-07-06T23:21:30.552487Z","end":"2026-07-06T23:21:30.681837Z","steps":["trace[2095589713] 'agreement among raft nodes before linearized reading' (duration: 128.704702ms)"],"step_count":1}