{"level":"warn","ts":"2026-07-24T04:41:26.192909Z","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-24T04:41:26.193023Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-24T04:41:26.193094Z","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-24T04:41:26.193125Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-07-24T04:41:26.193157Z","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-24T04:41:26.193767Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-07-24T04:41:26.193857Z","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.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-24T04:41:26.196095Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.892071ms"} {"level":"info","ts":"2026-07-24T04:41:26.200782Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-07-24T04:41:26.200869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-07-24T04:41:26.200907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-07-24T04:41:26.200946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-24T04:41:26.200978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-07-24T04:41:26.201031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-07-24T04:41:26.205022Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-24T04:41:26.207626Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-24T04:41:26.208517Z","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-24T04:41:26.210259Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-24T04:41:26.210895Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-24T04:41:26.211148Z","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-24T04:41:26.215257Z","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-24T04:41:26.215274Z","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-24T04:41:26.216142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-07-24T04:41:26.216451Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-07-24T04:41:26.218348Z","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-24T04:41:26.218612Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-07-24T04:41:26.218864Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-24T04:41:26.218709Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-07-24T04:41:26.218709Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-24T04:41:27.101693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-07-24T04:41:27.101769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-24T04:41:27.101805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-07-24T04:41:27.101831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-07-24T04:41:27.101847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-07-24T04:41:27.101869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-07-24T04:41:27.101885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-07-24T04:41:27.102895Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T04:41:27.1041Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-07-24T04:41:27.104592Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-24T04:41:27.104894Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-24T04:41:27.104948Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-24T04:41:27.104965Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-24T04:41:27.105131Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T04:41:27.105239Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T04:41:27.105269Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T04:41:27.106183Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-07-24T04:41:27.10807Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-24T04:41:33.066352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.208944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-24T04:41:33.066717Z","caller":"traceutil/trace.go:171","msg":"trace[1972587217] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:317; }","duration":"103.637607ms","start":"2026-07-24T04:41:32.963051Z","end":"2026-07-24T04:41:33.066689Z","steps":["trace[1972587217] 'range keys from in-memory index tree' (duration: 103.09673ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:41:35.029014Z","caller":"traceutil/trace.go:171","msg":"trace[254038770] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"100.985274ms","start":"2026-07-24T04:41:34.928001Z","end":"2026-07-24T04:41:35.028986Z","steps":["trace[254038770] 'process raft request' (duration: 100.754768ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:41:35.944408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.771744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-24T04:41:35.944503Z","caller":"traceutil/trace.go:171","msg":"trace[989134835] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:337; }","duration":"181.903817ms","start":"2026-07-24T04:41:35.762572Z","end":"2026-07-24T04:41:35.944475Z","steps":["trace[989134835] 'range keys from in-memory index tree' (duration: 181.677622ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:04.832851Z","caller":"traceutil/trace.go:171","msg":"trace[1097558878] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:545; }","duration":"184.701756ms","start":"2026-07-24T04:42:04.648126Z","end":"2026-07-24T04:42:04.832828Z","steps":["trace[1097558878] 'read index received' (duration: 184.52464ms)","trace[1097558878] 'applied index is now lower than readState.Index' (duration: 176.186µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:42:04.832943Z","caller":"traceutil/trace.go:171","msg":"trace[2098272181] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"190.649705ms","start":"2026-07-24T04:42:04.642268Z","end":"2026-07-24T04:42:04.832917Z","steps":["trace[2098272181] 'process raft request' (duration: 190.401208ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:04.832976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.827769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T04:42:04.833013Z","caller":"traceutil/trace.go:171","msg":"trace[1884282681] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:532; }","duration":"184.909792ms","start":"2026-07-24T04:42:04.648092Z","end":"2026-07-24T04:42:04.833002Z","steps":["trace[1884282681] 'agreement among raft nodes before linearized reading' (duration: 184.834669ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:05.175095Z","caller":"traceutil/trace.go:171","msg":"trace[1938958265] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"159.635958ms","start":"2026-07-24T04:42:05.015439Z","end":"2026-07-24T04:42:05.175075Z","steps":["trace[1938958265] 'process raft request' (duration: 159.521565ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:05.182842Z","caller":"traceutil/trace.go:171","msg":"trace[1965618087] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"156.115718ms","start":"2026-07-24T04:42:05.026702Z","end":"2026-07-24T04:42:05.182818Z","steps":["trace[1965618087] 'process raft request' (duration: 155.962183ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:05.182969Z","caller":"traceutil/trace.go:171","msg":"trace[1355098533] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"156.091527ms","start":"2026-07-24T04:42:05.026818Z","end":"2026-07-24T04:42:05.18291Z","steps":["trace[1355098533] 'process raft request' (duration: 155.955573ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:05.183063Z","caller":"traceutil/trace.go:171","msg":"trace[981754990] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"145.116623ms","start":"2026-07-24T04:42:05.037889Z","end":"2026-07-24T04:42:05.183005Z","steps":["trace[981754990] 'process raft request' (duration: 144.950448ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:05.183205Z","caller":"traceutil/trace.go:171","msg":"trace[1378020390] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"137.608157ms","start":"2026-07-24T04:42:05.045586Z","end":"2026-07-24T04:42:05.183194Z","steps":["trace[1378020390] 'process raft request' (duration: 137.36521ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:05.183273Z","caller":"traceutil/trace.go:171","msg":"trace[2079443121] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"141.062957ms","start":"2026-07-24T04:42:05.042197Z","end":"2026-07-24T04:42:05.18326Z","steps":["trace[2079443121] 'process raft request' (duration: 140.715247ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:05.183306Z","caller":"traceutil/trace.go:171","msg":"trace[2119637200] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"133.305775ms","start":"2026-07-24T04:42:05.049991Z","end":"2026-07-24T04:42:05.183297Z","steps":["trace[2119637200] 'process raft request' (duration: 132.998956ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:05.183386Z","caller":"traceutil/trace.go:171","msg":"trace[1741635227] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"133.330485ms","start":"2026-07-24T04:42:05.050047Z","end":"2026-07-24T04:42:05.183377Z","steps":["trace[1741635227] 'process raft request' (duration: 133.026137ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:05.183407Z","caller":"traceutil/trace.go:171","msg":"trace[327794351] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"125.303685ms","start":"2026-07-24T04:42:05.058094Z","end":"2026-07-24T04:42:05.183397Z","steps":["trace[327794351] 'process raft request' (duration: 125.081989ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:05.183509Z","caller":"traceutil/trace.go:171","msg":"trace[1938233280] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"113.307562ms","start":"2026-07-24T04:42:05.070192Z","end":"2026-07-24T04:42:05.1835Z","steps":["trace[1938233280] 'process raft request' (duration: 113.065425ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:11.374633Z","caller":"traceutil/trace.go:171","msg":"trace[796633577] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"134.107818ms","start":"2026-07-24T04:42:11.240499Z","end":"2026-07-24T04:42:11.374607Z","steps":["trace[796633577] 'read index received' (duration: 133.138741ms)","trace[796633577] 'applied index is now lower than readState.Index' (duration: 968.127µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:42:11.374936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.395357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-24T04:42:11.37477Z","caller":"traceutil/trace.go:171","msg":"trace[2073871293] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"386.48302ms","start":"2026-07-24T04:42:10.988236Z","end":"2026-07-24T04:42:11.374719Z","steps":["trace[2073871293] 'process raft request' (duration: 385.724469ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:11.375027Z","caller":"traceutil/trace.go:171","msg":"trace[1357531149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"134.515969ms","start":"2026-07-24T04:42:11.240457Z","end":"2026-07-24T04:42:11.374973Z","steps":["trace[1357531149] 'agreement among raft nodes before linearized reading' (duration: 134.247551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:11.37645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:10.988209Z","time spent":"386.790689ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T04:42:12.004346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.701913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T04:42:12.004509Z","caller":"traceutil/trace.go:171","msg":"trace[138019023] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"325.108943ms","start":"2026-07-24T04:42:11.679384Z","end":"2026-07-24T04:42:12.004493Z","steps":["trace[138019023] 'read index received' (duration: 114.317401ms)","trace[138019023] 'applied index is now lower than readState.Index' (duration: 210.790542ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:42:12.004648Z","caller":"traceutil/trace.go:171","msg":"trace[1991566861] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"549.098845ms","start":"2026-07-24T04:42:11.455523Z","end":"2026-07-24T04:42:12.004621Z","steps":["trace[1991566861] 'process raft request' (duration: 548.918389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:12.004822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.404382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gj2tj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-24T04:42:12.004855Z","caller":"traceutil/trace.go:171","msg":"trace[1422314467] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gj2tj; range_end:; response_count:1; response_revision:631; }","duration":"325.515376ms","start":"2026-07-24T04:42:11.679329Z","end":"2026-07-24T04:42:12.004845Z","steps":["trace[1422314467] 'agreement among raft nodes before linearized reading' (duration: 325.362651ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:12.004888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:11.679312Z","time spent":"325.567967ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16986,"request content":"key:\"/registry/pods/kube-system/cilium-gj2tj\" "} {"level":"info","ts":"2026-07-24T04:42:12.005165Z","caller":"traceutil/trace.go:171","msg":"trace[1746964436] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"625.598243ms","start":"2026-07-24T04:42:11.379548Z","end":"2026-07-24T04:42:12.005146Z","steps":["trace[1746964436] 'process raft request' (duration: 17.868661ms)","trace[1746964436] 'compare' (duration: 606.375994ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:42:12.005254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:11.379512Z","time spent":"625.701696ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T04:42:12.006422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:11.455491Z","time spent":"549.220296ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T04:42:12.209922Z","caller":"traceutil/trace.go:171","msg":"trace[110537160] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"191.091039ms","start":"2026-07-24T04:42:12.018803Z","end":"2026-07-24T04:42:12.209894Z","steps":["trace[110537160] 'process raft request' (duration: 180.321261ms)","trace[110537160] 'compare' (duration: 10.236853ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:42:13.012837Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920882491708522120,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-24T04:42:13.446648Z","caller":"traceutil/trace.go:171","msg":"trace[812571479] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.00881211s","start":"2026-07-24T04:42:12.437813Z","end":"2026-07-24T04:42:13.446625Z","steps":["trace[812571479] 'process raft request' (duration: 1.007462792s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:13.44737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:12.437783Z","time spent":"1.008936033s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036157,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:42:13.472719Z","caller":"traceutil/trace.go:171","msg":"trace[193218795] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"960.717485ms","start":"2026-07-24T04:42:12.511939Z","end":"2026-07-24T04:42:13.472657Z","steps":["trace[193218795] 'read index received' (duration: 932.588159ms)","trace[193218795] 'applied index is now lower than readState.Index' (duration: 28.128496ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:42:13.472795Z","caller":"traceutil/trace.go:171","msg":"trace[2130034885] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"932.792924ms","start":"2026-07-24T04:42:12.539995Z","end":"2026-07-24T04:42:13.472788Z","steps":["trace[2130034885] 'process raft request' (duration: 932.433654ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:13.472909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.968081ms","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-24T04:42:13.472913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.821909ms","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-24T04:42:13.472935Z","caller":"traceutil/trace.go:171","msg":"trace[1089871342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"961.040274ms","start":"2026-07-24T04:42:12.511888Z","end":"2026-07-24T04:42:13.472928Z","steps":["trace[1089871342] 'agreement among raft nodes before linearized reading' (duration: 960.943521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:13.472964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:12.511868Z","time spent":"961.091935ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-24T04:42:13.472967Z","caller":"traceutil/trace.go:171","msg":"trace[873812390] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"575.920032ms","start":"2026-07-24T04:42:12.897035Z","end":"2026-07-24T04:42:13.472955Z","steps":["trace[873812390] 'agreement among raft nodes before linearized reading' (duration: 575.784579ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:13.472991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:12.897012Z","time spent":"575.975473ms","remote":"127.0.0.1:43720","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-24T04:42:13.47325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:12.539965Z","time spent":"932.845236ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:42:15.124958Z","caller":"traceutil/trace.go:171","msg":"trace[1320875347] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"248.735138ms","start":"2026-07-24T04:42:14.876195Z","end":"2026-07-24T04:42:15.12493Z","steps":["trace[1320875347] 'process raft request' (duration: 242.430998ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:15.12691Z","caller":"traceutil/trace.go:171","msg":"trace[468180426] linearizableReadLoop","detail":"{readStateIndex:695; appliedIndex:693; }","duration":"182.817112ms","start":"2026-07-24T04:42:14.94406Z","end":"2026-07-24T04:42:15.126877Z","steps":["trace[468180426] 'read index received' (duration: 173.994889ms)","trace[468180426] 'applied index is now lower than readState.Index' (duration: 8.821343ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:42:15.127058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.011468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T04:42:15.127109Z","caller":"traceutil/trace.go:171","msg":"trace[50514774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:674; }","duration":"183.11408ms","start":"2026-07-24T04:42:14.943987Z","end":"2026-07-24T04:42:15.127101Z","steps":["trace[50514774] 'agreement among raft nodes before linearized reading' (duration: 182.987156ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:15.12742Z","caller":"traceutil/trace.go:171","msg":"trace[888876330] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"237.772545ms","start":"2026-07-24T04:42:14.889637Z","end":"2026-07-24T04:42:15.12741Z","steps":["trace[888876330] 'process raft request' (duration: 237.144497ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:15.852683Z","caller":"traceutil/trace.go:171","msg":"trace[1357212030] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"131.178494ms","start":"2026-07-24T04:42:15.721482Z","end":"2026-07-24T04:42:15.852661Z","steps":["trace[1357212030] 'process raft request' (duration: 131.124413ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:42:15.853027Z","caller":"traceutil/trace.go:171","msg":"trace[1586732191] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"149.86091ms","start":"2026-07-24T04:42:15.703156Z","end":"2026-07-24T04:42:15.853017Z","steps":["trace[1586732191] 'process raft request' (duration: 58.512886ms)","trace[1586732191] 'compare' (duration: 90.786568ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:42:15.853301Z","caller":"traceutil/trace.go:171","msg":"trace[2048848678] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:706; }","duration":"150.012923ms","start":"2026-07-24T04:42:15.703278Z","end":"2026-07-24T04:42:15.853291Z","steps":["trace[2048848678] 'read index received' (duration: 12.512479ms)","trace[2048848678] 'applied index is now lower than readState.Index' (duration: 137.499214ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:42:15.853583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.303122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gj2tj\" ","response":"range_response_count:1 size:17524"} {"level":"info","ts":"2026-07-24T04:42:15.85373Z","caller":"traceutil/trace.go:171","msg":"trace[1078154175] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gj2tj; range_end:; response_count:1; response_revision:686; }","duration":"150.469806ms","start":"2026-07-24T04:42:15.703226Z","end":"2026-07-24T04:42:15.853696Z","steps":["trace[1078154175] 'agreement among raft nodes before linearized reading' (duration: 150.105896ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:28.445414Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920882491708522437,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-24T04:42:28.536863Z","caller":"traceutil/trace.go:171","msg":"trace[1521579673] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:828; }","duration":"592.529627ms","start":"2026-07-24T04:42:27.944314Z","end":"2026-07-24T04:42:28.536844Z","steps":["trace[1521579673] 'read index received' (duration: 592.372443ms)","trace[1521579673] 'applied index is now lower than readState.Index' (duration: 145.683µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:42:28.536956Z","caller":"traceutil/trace.go:171","msg":"trace[1510040425] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"752.937797ms","start":"2026-07-24T04:42:27.784012Z","end":"2026-07-24T04:42:28.53695Z","steps":["trace[1510040425] 'process raft request' (duration: 752.68911ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:28.537039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:27.783985Z","time spent":"752.990889ms","remote":"127.0.0.1:43644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T04:42:28.53717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.862396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T04:42:28.537194Z","caller":"traceutil/trace.go:171","msg":"trace[825272085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"592.915767ms","start":"2026-07-24T04:42:27.944272Z","end":"2026-07-24T04:42:28.537188Z","steps":["trace[825272085] 'agreement among raft nodes before linearized reading' (duration: 592.877717ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:28.537214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:27.944255Z","time spent":"592.953069ms","remote":"127.0.0.1:43466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-24T04:42:28.537217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.43934ms","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-24T04:42:28.537283Z","caller":"traceutil/trace.go:171","msg":"trace[854039651] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:803; }","duration":"197.570054ms","start":"2026-07-24T04:42:28.3397Z","end":"2026-07-24T04:42:28.53727Z","steps":["trace[854039651] 'agreement among raft nodes before linearized reading' (duration: 197.375278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:28.537391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.786909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-24T04:42:28.537453Z","caller":"traceutil/trace.go:171","msg":"trace[1244158781] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:803; }","duration":"227.915082ms","start":"2026-07-24T04:42:28.309524Z","end":"2026-07-24T04:42:28.537439Z","steps":["trace[1244158781] 'agreement among raft nodes before linearized reading' (duration: 227.788849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:28.537989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.935348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-24T04:42:28.538095Z","caller":"traceutil/trace.go:171","msg":"trace[730131196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:803; }","duration":"456.097723ms","start":"2026-07-24T04:42:28.08198Z","end":"2026-07-24T04:42:28.538078Z","steps":["trace[730131196] 'agreement among raft nodes before linearized reading' (duration: 455.078933ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:42:28.539306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:42:28.081955Z","time spent":"457.333858ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-24T04:43:02.962003Z","caller":"traceutil/trace.go:171","msg":"trace[204501078] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"266.280191ms","start":"2026-07-24T04:43:02.695699Z","end":"2026-07-24T04:43:02.961979Z","steps":["trace[204501078] 'process raft request' (duration: 265.843988ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:02.962331Z","caller":"traceutil/trace.go:171","msg":"trace[1188260651] linearizableReadLoop","detail":"{readStateIndex:1050; appliedIndex:1050; }","duration":"258.821452ms","start":"2026-07-24T04:43:02.703474Z","end":"2026-07-24T04:43:02.962296Z","steps":["trace[1188260651] 'read index received' (duration: 258.806821ms)","trace[1188260651] 'applied index is now lower than readState.Index' (duration: 12.021µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:43:02.962661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.157271ms","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-24T04:43:02.962729Z","caller":"traceutil/trace.go:171","msg":"trace[564495673] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1014; }","duration":"259.270365ms","start":"2026-07-24T04:43:02.703441Z","end":"2026-07-24T04:43:02.962712Z","steps":["trace[564495673] 'agreement among raft nodes before linearized reading' (duration: 259.028718ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:04.055075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.627656ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T04:43:04.055278Z","caller":"traceutil/trace.go:171","msg":"trace[645107187] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1051; }","duration":"1.070146877s","start":"2026-07-24T04:43:02.985116Z","end":"2026-07-24T04:43:04.055263Z","steps":["trace[645107187] 'read index received' (duration: 389.178561ms)","trace[645107187] 'applied index is now lower than readState.Index' (duration: 680.965416ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:43:04.055487Z","caller":"traceutil/trace.go:171","msg":"trace[969161884] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"1.08957801s","start":"2026-07-24T04:43:02.965897Z","end":"2026-07-24T04:43:04.055475Z","steps":["trace[969161884] 'process raft request' (duration: 408.4731ms)","trace[969161884] 'compare' (duration: 680.304707ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:43:04.055551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:02.965881Z","time spent":"1.089639772s","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T04:43:04.055704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.215135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T04:43:04.055708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.022635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T04:43:04.05571Z","caller":"traceutil/trace.go:171","msg":"trace[175485412] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"1.089364215s","start":"2026-07-24T04:43:02.966304Z","end":"2026-07-24T04:43:04.055668Z","steps":["trace[175485412] 'process raft request' (duration: 1.08887104s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:04.055781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.123994ms","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-24T04:43:04.055781Z","caller":"traceutil/trace.go:171","msg":"trace[1199299476] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1017; }","duration":"412.147499ms","start":"2026-07-24T04:43:03.643617Z","end":"2026-07-24T04:43:04.055765Z","steps":["trace[1199299476] 'agreement among raft nodes before linearized reading' (duration: 412.020545ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:04.055813Z","caller":"traceutil/trace.go:171","msg":"trace[832877643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1017; }","duration":"358.190676ms","start":"2026-07-24T04:43:03.697612Z","end":"2026-07-24T04:43:04.055803Z","steps":["trace[832877643] 'agreement among raft nodes before linearized reading' (duration: 358.087413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:04.055824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:03.643595Z","time spent":"412.219191ms","remote":"127.0.0.1:43536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-07-24T04:43:04.055846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:03.697591Z","time spent":"358.248848ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-24T04:43:04.055763Z","caller":"traceutil/trace.go:171","msg":"trace[584284549] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1017; }","duration":"110.326378ms","start":"2026-07-24T04:43:03.945424Z","end":"2026-07-24T04:43:04.05575Z","steps":["trace[584284549] 'agreement among raft nodes before linearized reading' (duration: 110.211484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:04.05582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.070682654s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-24T04:43:04.055907Z","caller":"traceutil/trace.go:171","msg":"trace[247585863] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1017; }","duration":"1.070810357s","start":"2026-07-24T04:43:02.985078Z","end":"2026-07-24T04:43:04.055889Z","steps":["trace[247585863] 'agreement among raft nodes before linearized reading' (duration: 1.070641291s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:04.0559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:02.966273Z","time spent":"1.08953364s","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T04:43:04.055959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:02.985064Z","time spent":"1.070885848s","remote":"127.0.0.1:43566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":28,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-07-24T04:43:04.056071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.336519ms","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-24T04:43:04.056182Z","caller":"traceutil/trace.go:171","msg":"trace[1467646993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1017; }","duration":"361.490733ms","start":"2026-07-24T04:43:03.694671Z","end":"2026-07-24T04:43:04.056162Z","steps":["trace[1467646993] 'agreement among raft nodes before linearized reading' (duration: 361.04522ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:04.056261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:03.694649Z","time spent":"361.599506ms","remote":"127.0.0.1:43720","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":"info","ts":"2026-07-24T04:43:04.174624Z","caller":"traceutil/trace.go:171","msg":"trace[1178992964] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"114.094469ms","start":"2026-07-24T04:43:04.060511Z","end":"2026-07-24T04:43:04.174606Z","steps":["trace[1178992964] 'process raft request' (duration: 113.993026ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:04.175975Z","caller":"traceutil/trace.go:171","msg":"trace[601492939] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"115.220462ms","start":"2026-07-24T04:43:04.060724Z","end":"2026-07-24T04:43:04.175944Z","steps":["trace[601492939] 'process raft request' (duration: 115.094027ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:26.43509Z","caller":"traceutil/trace.go:171","msg":"trace[1249547254] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1129; }","duration":"272.780384ms","start":"2026-07-24T04:43:26.162286Z","end":"2026-07-24T04:43:26.435067Z","steps":["trace[1249547254] 'read index received' (duration: 272.551388ms)","trace[1249547254] 'applied index is now lower than readState.Index' (duration: 228.066µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:43:26.435127Z","caller":"traceutil/trace.go:171","msg":"trace[1166466088] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"278.104331ms","start":"2026-07-24T04:43:26.156997Z","end":"2026-07-24T04:43:26.435101Z","steps":["trace[1166466088] 'process raft request' (duration: 277.926496ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:26.435327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.868648ms","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-24T04:43:26.435349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.717897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-24T04:43:26.435371Z","caller":"traceutil/trace.go:171","msg":"trace[1883543295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1089; }","duration":"160.791257ms","start":"2026-07-24T04:43:26.274572Z","end":"2026-07-24T04:43:26.435364Z","steps":["trace[1883543295] 'agreement among raft nodes before linearized reading' (duration: 160.692594ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:26.435369Z","caller":"traceutil/trace.go:171","msg":"trace[980721845] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1089; }","duration":"163.958542ms","start":"2026-07-24T04:43:26.271399Z","end":"2026-07-24T04:43:26.435358Z","steps":["trace[980721845] 'agreement among raft nodes before linearized reading' (duration: 163.807777ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:26.43553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.208437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-24T04:43:26.435661Z","caller":"traceutil/trace.go:171","msg":"trace[1067425060] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1089; }","duration":"273.382162ms","start":"2026-07-24T04:43:26.162253Z","end":"2026-07-24T04:43:26.435635Z","steps":["trace[1067425060] 'agreement among raft nodes before linearized reading' (duration: 273.017831ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:26.844216Z","caller":"traceutil/trace.go:171","msg":"trace[1483673129] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"404.852223ms","start":"2026-07-24T04:43:26.439344Z","end":"2026-07-24T04:43:26.844197Z","steps":["trace[1483673129] 'process raft request' (duration: 404.76553ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:26.844264Z","caller":"traceutil/trace.go:171","msg":"trace[73355274] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"405.086341ms","start":"2026-07-24T04:43:26.439152Z","end":"2026-07-24T04:43:26.844239Z","steps":["trace[73355274] 'process raft request' (duration: 396.712094ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:26.8443Z","caller":"traceutil/trace.go:171","msg":"trace[59215188] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"404.626447ms","start":"2026-07-24T04:43:26.43965Z","end":"2026-07-24T04:43:26.844276Z","steps":["trace[59215188] 'process raft request' (duration: 404.520454ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:26.844326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:26.439321Z","time spent":"404.948267ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T04:43:26.844509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:26.439644Z","time spent":"404.711329ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T04:43:26.844561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:26.439131Z","time spent":"405.195973ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T04:43:27.203755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.679002ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T04:43:27.203872Z","caller":"traceutil/trace.go:171","msg":"trace[82805225] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"142.017194ms","start":"2026-07-24T04:43:27.061835Z","end":"2026-07-24T04:43:27.203852Z","steps":["trace[82805225] 'read index received' (duration: 17.105406ms)","trace[82805225] 'applied index is now lower than readState.Index' (duration: 124.910218ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:43:27.203936Z","caller":"traceutil/trace.go:171","msg":"trace[1221879132] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"168.080513ms","start":"2026-07-24T04:43:27.035822Z","end":"2026-07-24T04:43:27.203903Z","steps":["trace[1221879132] 'process raft request' (duration: 43.142504ms)","trace[1221879132] 'compare' (duration: 124.519797ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:43:27.204065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.22993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-24T04:43:27.204112Z","caller":"traceutil/trace.go:171","msg":"trace[164975235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1093; }","duration":"142.308121ms","start":"2026-07-24T04:43:27.061791Z","end":"2026-07-24T04:43:27.204099Z","steps":["trace[164975235] 'agreement among raft nodes before linearized reading' (duration: 142.115375ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:27.388462Z","caller":"traceutil/trace.go:171","msg":"trace[1097874617] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"180.223632ms","start":"2026-07-24T04:43:27.208213Z","end":"2026-07-24T04:43:27.388437Z","steps":["trace[1097874617] 'process raft request' (duration: 180.037136ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:28.636108Z","caller":"traceutil/trace.go:171","msg":"trace[1468128783] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"193.71054ms","start":"2026-07-24T04:43:28.442367Z","end":"2026-07-24T04:43:28.636078Z","steps":["trace[1468128783] 'process raft request' (duration: 193.514304ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:29.996319Z","caller":"traceutil/trace.go:171","msg":"trace[1648737604] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"600.365557ms","start":"2026-07-24T04:43:29.395928Z","end":"2026-07-24T04:43:29.996293Z","steps":["trace[1648737604] 'process raft request' (duration: 599.865832ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:29.996466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:29.395903Z","time spent":"600.4854ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T04:43:45.521936Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920882491708523355,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-24T04:43:45.897448Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.185533616s","expected-duration":"1s"} {"level":"info","ts":"2026-07-24T04:43:45.89781Z","caller":"traceutil/trace.go:171","msg":"trace[1431070313] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"1.185974729s","start":"2026-07-24T04:43:44.711812Z","end":"2026-07-24T04:43:45.897787Z","steps":["trace[1431070313] 'process raft request' (duration: 1.185818263s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:45.897939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:44.711783Z","time spent":"1.18607816s","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:43:45.901858Z","caller":"traceutil/trace.go:171","msg":"trace[1283493488] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"962.634272ms","start":"2026-07-24T04:43:44.939204Z","end":"2026-07-24T04:43:45.901838Z","steps":["trace[1283493488] 'process raft request' (duration: 962.470828ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:45.901942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:44.93918Z","time spent":"962.718395ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:43:45.901911Z","caller":"traceutil/trace.go:171","msg":"trace[1568902171] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"622.245993ms","start":"2026-07-24T04:43:45.279628Z","end":"2026-07-24T04:43:45.901874Z","steps":["trace[1568902171] 'process raft request' (duration: 622.12974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:45.902073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:45.279602Z","time spent":"622.390586ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:43:45.912372Z","caller":"traceutil/trace.go:171","msg":"trace[1074915092] linearizableReadLoop","detail":"{readStateIndex:1249; appliedIndex:1245; }","duration":"891.477542ms","start":"2026-07-24T04:43:45.02087Z","end":"2026-07-24T04:43:45.912347Z","steps":["trace[1074915092] 'read index received' (duration: 876.755627ms)","trace[1074915092] 'applied index is now lower than readState.Index' (duration: 14.720475ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:43:45.912524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.655258ms","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-24T04:43:45.91253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.382922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T04:43:45.912561Z","caller":"traceutil/trace.go:171","msg":"trace[542609855] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1202; }","duration":"891.717419ms","start":"2026-07-24T04:43:45.020832Z","end":"2026-07-24T04:43:45.91255Z","steps":["trace[542609855] 'agreement among raft nodes before linearized reading' (duration: 891.583406ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:43:45.912572Z","caller":"traceutil/trace.go:171","msg":"trace[340278184] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1202; }","duration":"147.471544ms","start":"2026-07-24T04:43:45.765086Z","end":"2026-07-24T04:43:45.912558Z","steps":["trace[340278184] 'agreement among raft nodes before linearized reading' (duration: 147.399322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:45.91259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:45.020812Z","time spent":"891.77031ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-24T04:43:45.912587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.218207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-24T04:43:45.91263Z","caller":"traceutil/trace.go:171","msg":"trace[2099964238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1202; }","duration":"844.286919ms","start":"2026-07-24T04:43:45.068328Z","end":"2026-07-24T04:43:45.912615Z","steps":["trace[2099964238] 'agreement among raft nodes before linearized reading' (duration: 844.152585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:45.912657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.127724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-24T04:43:45.912669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:45.068316Z","time spent":"844.34284ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-24T04:43:45.912704Z","caller":"traceutil/trace.go:171","msg":"trace[1081446105] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1202; }","duration":"824.208236ms","start":"2026-07-24T04:43:45.088483Z","end":"2026-07-24T04:43:45.912691Z","steps":["trace[1081446105] 'agreement among raft nodes before linearized reading' (duration: 824.073402ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:43:45.912734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:43:45.088469Z","time spent":"824.259398ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-24T04:44:02.17354Z","caller":"traceutil/trace.go:171","msg":"trace[1520933922] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1323; }","duration":"206.109877ms","start":"2026-07-24T04:44:01.967396Z","end":"2026-07-24T04:44:02.173505Z","steps":["trace[1520933922] 'read index received' (duration: 205.909891ms)","trace[1520933922] 'applied index is now lower than readState.Index' (duration: 199.056µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T04:44:02.173623Z","caller":"traceutil/trace.go:171","msg":"trace[2124354032] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"219.849697ms","start":"2026-07-24T04:44:01.95374Z","end":"2026-07-24T04:44:02.17359Z","steps":["trace[2124354032] 'process raft request' (duration: 219.61737ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:02.17379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.376673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-24T04:44:02.173822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.95122ms","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-24T04:44:02.173867Z","caller":"traceutil/trace.go:171","msg":"trace[1545184160] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1274; }","duration":"194.057953ms","start":"2026-07-24T04:44:01.979797Z","end":"2026-07-24T04:44:02.173855Z","steps":["trace[1545184160] 'agreement among raft nodes before linearized reading' (duration: 193.860408ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:44:02.173866Z","caller":"traceutil/trace.go:171","msg":"trace[1487859683] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1274; }","duration":"206.508338ms","start":"2026-07-24T04:44:01.967341Z","end":"2026-07-24T04:44:02.173849Z","steps":["trace[1487859683] 'agreement among raft nodes before linearized reading' (duration: 206.265322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:02.174038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.005631ms","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-24T04:44:02.174075Z","caller":"traceutil/trace.go:171","msg":"trace[1693433948] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1274; }","duration":"168.082534ms","start":"2026-07-24T04:44:02.005982Z","end":"2026-07-24T04:44:02.174065Z","steps":["trace[1693433948] 'agreement among raft nodes before linearized reading' (duration: 167.978301ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:02.174074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.168061ms","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-24T04:44:02.17412Z","caller":"traceutil/trace.go:171","msg":"trace[232097763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1274; }","duration":"170.234053ms","start":"2026-07-24T04:44:02.003871Z","end":"2026-07-24T04:44:02.174105Z","steps":["trace[232097763] 'agreement among raft nodes before linearized reading' (duration: 170.12057ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:02.64121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.083347ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T04:44:02.641331Z","caller":"traceutil/trace.go:171","msg":"trace[533076355] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"464.332586ms","start":"2026-07-24T04:44:02.17696Z","end":"2026-07-24T04:44:02.641293Z","steps":["trace[533076355] 'process raft request' (duration: 90.081784ms)","trace[533076355] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-controller-manager; req_size:488; } (duration: 373.799369ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:44:02.641396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:44:02.176938Z","time spent":"464.429408ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:44:02.680263Z","caller":"traceutil/trace.go:171","msg":"trace[1677748402] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"501.893255ms","start":"2026-07-24T04:44:02.178353Z","end":"2026-07-24T04:44:02.680246Z","steps":["trace[1677748402] 'process raft request' (duration: 501.727381ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:02.680356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:44:02.178331Z","time spent":"501.981127ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:44:02.680434Z","caller":"traceutil/trace.go:171","msg":"trace[1495165716] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"501.426052ms","start":"2026-07-24T04:44:02.178992Z","end":"2026-07-24T04:44:02.680418Z","steps":["trace[1495165716] 'process raft request' (duration: 501.216617ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:02.680524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:44:02.178974Z","time spent":"501.506316ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:44:02.680602Z","caller":"traceutil/trace.go:171","msg":"trace[779396246] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"500.994581ms","start":"2026-07-24T04:44:02.179597Z","end":"2026-07-24T04:44:02.680592Z","steps":["trace[779396246] 'process raft request' (duration: 500.753014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:02.680665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:44:02.179569Z","time spent":"501.067573ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:44:02.680793Z","caller":"traceutil/trace.go:171","msg":"trace[1583441547] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"501.015051ms","start":"2026-07-24T04:44:02.179767Z","end":"2026-07-24T04:44:02.680782Z","steps":["trace[1583441547] 'process raft request' (duration: 500.785195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:02.680859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:44:02.179759Z","time spent":"501.066762ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:44:03.317288Z","caller":"traceutil/trace.go:171","msg":"trace[1598373917] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"252.11163ms","start":"2026-07-24T04:44:03.065162Z","end":"2026-07-24T04:44:03.317273Z","steps":["trace[1598373917] 'process raft request' (duration: 251.911424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:03.317448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.69302ms","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-24T04:44:03.317529Z","caller":"traceutil/trace.go:171","msg":"trace[28657280] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1282; }","duration":"251.798801ms","start":"2026-07-24T04:44:03.065709Z","end":"2026-07-24T04:44:03.317508Z","steps":["trace[28657280] 'agreement among raft nodes before linearized reading' (duration: 251.647498ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:44:03.317235Z","caller":"traceutil/trace.go:171","msg":"trace[210564524] linearizableReadLoop","detail":"{readStateIndex:1332; appliedIndex:1331; }","duration":"251.479064ms","start":"2026-07-24T04:44:03.065733Z","end":"2026-07-24T04:44:03.317212Z","steps":["trace[210564524] 'read index received' (duration: 251.303859ms)","trace[210564524] 'applied index is now lower than readState.Index' (duration: 173.995µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:44:03.718026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.007666ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-24T04:44:03.718223Z","caller":"traceutil/trace.go:171","msg":"trace[1150275557] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"396.276972ms","start":"2026-07-24T04:44:03.321916Z","end":"2026-07-24T04:44:03.718193Z","steps":["trace[1150275557] 'process raft request' (duration: 396.20348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:03.718277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:44:03.3219Z","time spent":"396.354793ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":456,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T04:44:03.718306Z","caller":"traceutil/trace.go:171","msg":"trace[796369899] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"396.951931ms","start":"2026-07-24T04:44:03.321323Z","end":"2026-07-24T04:44:03.718275Z","steps":["trace[796369899] 'process raft request' (duration: 139.614396ms)","trace[796369899] 'compare' (duration: 256.594194ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:44:03.718432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:44:03.321296Z","time spent":"397.074804ms","remote":"127.0.0.1:43532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T04:44:04.570118Z","caller":"traceutil/trace.go:171","msg":"trace[1720603620] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"391.662824ms","start":"2026-07-24T04:44:04.178427Z","end":"2026-07-24T04:44:04.57009Z","steps":["trace[1720603620] 'process raft request' (duration: 391.414188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:04.570263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:44:04.178399Z","time spent":"391.788657ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:44:04.725837Z","caller":"traceutil/trace.go:171","msg":"trace[1943755159] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"114.460609ms","start":"2026-07-24T04:44:04.611358Z","end":"2026-07-24T04:44:04.725819Z","steps":["trace[1943755159] 'process raft request' (duration: 114.14965ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T04:44:13.967387Z","caller":"traceutil/trace.go:171","msg":"trace[1025666161] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"210.292392ms","start":"2026-07-24T04:44:13.757068Z","end":"2026-07-24T04:44:13.96736Z","steps":["trace[1025666161] 'process raft request' (duration: 210.065346ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T04:44:14.686625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.199337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T04:44:14.686722Z","caller":"traceutil/trace.go:171","msg":"trace[970792431] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"706.989815ms","start":"2026-07-24T04:44:13.979718Z","end":"2026-07-24T04:44:14.686708Z","steps":["trace[970792431] 'process raft request' (duration: 572.644406ms)","trace[970792431] 'compare' (duration: 134.04662ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T04:44:14.686797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T04:44:13.979706Z","time spent":"707.061917ms","remote":"127.0.0.1:43720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T04:44:14.733415Z","caller":"traceutil/trace.go:171","msg":"trace[1579393166] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"126.167752ms","start":"2026-07-24T04:44:14.607221Z","end":"2026-07-24T04:44:14.733388Z","steps":["trace[1579393166] 'process raft request' (duration: 126.026319ms)"],"step_count":1}