{"level":"warn","ts":"2026-05-14T07:35:12.686782Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-14T07:35:12.686903Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250: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-05-14T07:35:12.687011Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-14T07:35:12.687033Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-05-14T07:35:12.687064Z","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-05-14T07:35:12.68779Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-05-14T07:35:12.68789Z","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.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250: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-05-14T07:35:12.6926Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.483295ms"} {"level":"info","ts":"2026-05-14T07:35:12.70074Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-05-14T07:35:12.70085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-05-14T07:35:12.700888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-05-14T07:35:12.700903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-14T07:35:12.700928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-05-14T07:35:12.700982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-05-14T07:35:12.70871Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-14T07:35:12.710687Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-14T07:35:12.712303Z","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-05-14T07:35:12.717396Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-14T07:35:12.717617Z","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-05-14T07:35:12.717752Z","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-05-14T07:35:12.717771Z","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-05-14T07:35:12.718157Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-14T07:35:12.719134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-05-14T07:35:12.719266Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-05-14T07:35:12.72219Z","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-05-14T07:35:12.72244Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-14T07:35:12.722475Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-14T07:35:12.722637Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-05-14T07:35:12.722651Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-05-14T07:35:13.302726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-05-14T07:35:13.302787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-14T07:35:13.302816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-05-14T07:35:13.302829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-05-14T07:35:13.302835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-05-14T07:35:13.302845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-05-14T07:35:13.302856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-05-14T07:35:13.311668Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T07:35:13.312862Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-05-14T07:35:13.313289Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T07:35:13.313439Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T07:35:13.314631Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T07:35:13.314744Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T07:35:13.314874Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T07:35:13.315074Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-14T07:35:13.315192Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-14T07:35:13.316392Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-14T07:35:13.318487Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-05-14T07:35:17.891414Z","caller":"traceutil/trace.go:171","msg":"trace[366559294] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"122.063229ms","start":"2026-05-14T07:35:17.769319Z","end":"2026-05-14T07:35:17.891382Z","steps":["trace[366559294] 'process raft request' (duration: 121.885248ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:17.900155Z","caller":"traceutil/trace.go:171","msg":"trace[1905579498] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"107.191523ms","start":"2026-05-14T07:35:17.792945Z","end":"2026-05-14T07:35:17.900137Z","steps":["trace[1905579498] 'process raft request' (duration: 107.111992ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:18.757691Z","caller":"traceutil/trace.go:171","msg":"trace[514724245] linearizableReadLoop","detail":"{readStateIndex:292; appliedIndex:291; }","duration":"143.02993ms","start":"2026-05-14T07:35:18.614629Z","end":"2026-05-14T07:35:18.757659Z","steps":["trace[514724245] 'read index received' (duration: 49.260716ms)","trace[514724245] 'applied index is now lower than readState.Index' (duration: 93.767614ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:18.757747Z","caller":"traceutil/trace.go:171","msg":"trace[1204807148] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"144.732675ms","start":"2026-05-14T07:35:18.612961Z","end":"2026-05-14T07:35:18.757693Z","steps":["trace[1204807148] 'process raft request' (duration: 50.983881ms)","trace[1204807148] 'compare' (duration: 93.585472ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:18.757962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.271762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-05-14T07:35:18.758132Z","caller":"traceutil/trace.go:171","msg":"trace[717494879] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:286; }","duration":"143.497624ms","start":"2026-05-14T07:35:18.614608Z","end":"2026-05-14T07:35:18.758105Z","steps":["trace[717494879] 'agreement among raft nodes before linearized reading' (duration: 143.180191ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:18.771788Z","caller":"traceutil/trace.go:171","msg":"trace[910081619] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"111.310313ms","start":"2026-05-14T07:35:18.66046Z","end":"2026-05-14T07:35:18.77177Z","steps":["trace[910081619] 'process raft request' (duration: 111.279972ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:18.77185Z","caller":"traceutil/trace.go:171","msg":"trace[293756709] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"156.225276ms","start":"2026-05-14T07:35:18.615593Z","end":"2026-05-14T07:35:18.771818Z","steps":["trace[293756709] 'process raft request' (duration: 156.071695ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:18.796057Z","caller":"traceutil/trace.go:171","msg":"trace[786281885] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"115.440833ms","start":"2026-05-14T07:35:18.680577Z","end":"2026-05-14T07:35:18.796018Z","steps":["trace[786281885] 'process raft request' (duration: 115.203911ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:18.796187Z","caller":"traceutil/trace.go:171","msg":"trace[1827005955] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"114.414494ms","start":"2026-05-14T07:35:18.681726Z","end":"2026-05-14T07:35:18.796141Z","steps":["trace[1827005955] 'process raft request' (duration: 114.265853ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:18.796287Z","caller":"traceutil/trace.go:171","msg":"trace[1489173129] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"115.571365ms","start":"2026-05-14T07:35:18.680654Z","end":"2026-05-14T07:35:18.796225Z","steps":["trace[1489173129] 'process raft request' (duration: 115.231552ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:18.796346Z","caller":"traceutil/trace.go:171","msg":"trace[89716030] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"114.566885ms","start":"2026-05-14T07:35:18.681769Z","end":"2026-05-14T07:35:18.796336Z","steps":["trace[89716030] 'process raft request' (duration: 114.270082ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:18.796298Z","caller":"traceutil/trace.go:171","msg":"trace[2114724534] transaction","detail":"{read_only:false; number_of_response:0; response_revision:290; }","duration":"114.520674ms","start":"2026-05-14T07:35:18.681758Z","end":"2026-05-14T07:35:18.796278Z","steps":["trace[2114724534] 'process raft request' (duration: 114.324412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:18.796822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.040025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-14T07:35:18.796921Z","caller":"traceutil/trace.go:171","msg":"trace[1645936020] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:292; }","duration":"182.189967ms","start":"2026-05-14T07:35:18.614716Z","end":"2026-05-14T07:35:18.796906Z","steps":["trace[1645936020] 'agreement among raft nodes before linearized reading' (duration: 181.979185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:18.796822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.067416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-14T07:35:18.79718Z","caller":"traceutil/trace.go:171","msg":"trace[334614172] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:292; }","duration":"182.423159ms","start":"2026-05-14T07:35:18.614727Z","end":"2026-05-14T07:35:18.79715Z","steps":["trace[334614172] 'agreement among raft nodes before linearized reading' (duration: 181.971435ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:18.913007Z","caller":"traceutil/trace.go:171","msg":"trace[119815497] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"105.666449ms","start":"2026-05-14T07:35:18.807307Z","end":"2026-05-14T07:35:18.912973Z","steps":["trace[119815497] 'process raft request' (duration: 69.926624ms)","trace[119815497] 'compare' (duration: 35.523633ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:18.913247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.093133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:35:18.91337Z","caller":"traceutil/trace.go:171","msg":"trace[589399939] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:0; response_revision:297; }","duration":"106.227134ms","start":"2026-05-14T07:35:18.807102Z","end":"2026-05-14T07:35:18.913329Z","steps":["trace[589399939] 'agreement among raft nodes before linearized reading' (duration: 106.023992ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:19.034461Z","caller":"traceutil/trace.go:171","msg":"trace[690286667] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"114.281711ms","start":"2026-05-14T07:35:18.920136Z","end":"2026-05-14T07:35:19.034418Z","steps":["trace[690286667] 'process raft request' (duration: 100.835982ms)","trace[690286667] 'compare' (duration: 13.153836ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:19.03458Z","caller":"traceutil/trace.go:171","msg":"trace[609869365] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"114.360921ms","start":"2026-05-14T07:35:18.920207Z","end":"2026-05-14T07:35:19.034568Z","steps":["trace[609869365] 'process raft request' (duration: 114.108949ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:19.034462Z","caller":"traceutil/trace.go:171","msg":"trace[1608717500] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"112.388292ms","start":"2026-05-14T07:35:18.92204Z","end":"2026-05-14T07:35:19.034429Z","steps":["trace[1608717500] 'process raft request' (duration: 112.333341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:19.251293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.869533ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:35:19.251518Z","caller":"traceutil/trace.go:171","msg":"trace[596586060] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"131.571898ms","start":"2026-05-14T07:35:19.119922Z","end":"2026-05-14T07:35:19.251494Z","steps":["trace[596586060] 'process raft request' (duration: 131.495467ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:19.25158Z","caller":"traceutil/trace.go:171","msg":"trace[1188318473] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"133.668117ms","start":"2026-05-14T07:35:19.117856Z","end":"2026-05-14T07:35:19.251524Z","steps":["trace[1188318473] 'process raft request' (duration: 29.729103ms)","trace[1188318473] 'compare' (duration: 102.694361ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:19.870594Z","caller":"traceutil/trace.go:171","msg":"trace[1734998371] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"130.117724ms","start":"2026-05-14T07:35:19.740438Z","end":"2026-05-14T07:35:19.870556Z","steps":["trace[1734998371] 'process raft request' (duration: 108.88235ms)","trace[1734998371] 'compare' (duration: 20.97151ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:19.870771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.462947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-14T07:35:19.870838Z","caller":"traceutil/trace.go:171","msg":"trace[424832655] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:317; }","duration":"129.602419ms","start":"2026-05-14T07:35:19.741219Z","end":"2026-05-14T07:35:19.870822Z","steps":["trace[424832655] 'agreement among raft nodes before linearized reading' (duration: 129.436338ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:19.870513Z","caller":"traceutil/trace.go:171","msg":"trace[190213117] linearizableReadLoop","detail":"{readStateIndex:329; appliedIndex:328; }","duration":"129.201915ms","start":"2026-05-14T07:35:19.741278Z","end":"2026-05-14T07:35:19.87048Z","steps":["trace[190213117] 'read index received' (duration: 107.915041ms)","trace[190213117] 'applied index is now lower than readState.Index' (duration: 21.285624ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:22.242517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.266329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:35:22.242658Z","caller":"traceutil/trace.go:171","msg":"trace[1047003820] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:352; }","duration":"200.570707ms","start":"2026-05-14T07:35:22.042068Z","end":"2026-05-14T07:35:22.242638Z","steps":["trace[1047003820] 'read index received' (duration: 20.044237ms)","trace[1047003820] 'applied index is now lower than readState.Index' (duration: 180.52509ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:22.242726Z","caller":"traceutil/trace.go:171","msg":"trace[1542289569] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"211.745891ms","start":"2026-05-14T07:35:22.030944Z","end":"2026-05-14T07:35:22.24269Z","steps":["trace[1542289569] 'process raft request' (duration: 31.224231ms)","trace[1542289569] 'compare' (duration: 180.109216ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:22.243055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.966281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-14T07:35:22.243086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.874659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-14T07:35:22.243267Z","caller":"traceutil/trace.go:171","msg":"trace[645745496] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:341; }","duration":"101.083443ms","start":"2026-05-14T07:35:22.142128Z","end":"2026-05-14T07:35:22.243211Z","steps":["trace[645745496] 'agreement among raft nodes before linearized reading' (duration: 100.839469ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:22.243291Z","caller":"traceutil/trace.go:171","msg":"trace[1944545561] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:341; }","duration":"201.063563ms","start":"2026-05-14T07:35:22.042052Z","end":"2026-05-14T07:35:22.243115Z","steps":["trace[1944545561] 'agreement among raft nodes before linearized reading' (duration: 200.88704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:22.243657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.100257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-14T07:35:22.243967Z","caller":"traceutil/trace.go:171","msg":"trace[253467614] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:341; }","duration":"151.248768ms","start":"2026-05-14T07:35:22.092467Z","end":"2026-05-14T07:35:22.243715Z","steps":["trace[253467614] 'agreement among raft nodes before linearized reading' (duration: 150.304499ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:22.631591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.227696ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:35:22.631826Z","caller":"traceutil/trace.go:171","msg":"trace[1989743072] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"116.168611ms","start":"2026-05-14T07:35:22.515627Z","end":"2026-05-14T07:35:22.631796Z","steps":["trace[1989743072] 'compare' (duration: 110.068415ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:22.632Z","caller":"traceutil/trace.go:171","msg":"trace[576938418] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"113.878739ms","start":"2026-05-14T07:35:22.518107Z","end":"2026-05-14T07:35:22.631985Z","steps":["trace[576938418] 'process raft request' (duration: 113.674687ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:22.632317Z","caller":"traceutil/trace.go:171","msg":"trace[508073775] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"109.453389ms","start":"2026-05-14T07:35:22.52285Z","end":"2026-05-14T07:35:22.632304Z","steps":["trace[508073775] 'process raft request' (duration: 109.033795ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:22.633063Z","caller":"traceutil/trace.go:171","msg":"trace[1495711933] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"115.048911ms","start":"2026-05-14T07:35:22.517823Z","end":"2026-05-14T07:35:22.632872Z","steps":["trace[1495711933] 'process raft request' (duration: 113.86954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:22.877736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.426313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:35:22.878095Z","caller":"traceutil/trace.go:171","msg":"trace[1547458049] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"190.821117ms","start":"2026-05-14T07:35:22.687244Z","end":"2026-05-14T07:35:22.878065Z","steps":["trace[1547458049] 'process raft request' (duration: 56.611117ms)","trace[1547458049] 'compare' (duration: 132.790727ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:22.87895Z","caller":"traceutil/trace.go:171","msg":"trace[242842715] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"190.517204ms","start":"2026-05-14T07:35:22.688388Z","end":"2026-05-14T07:35:22.878905Z","steps":["trace[242842715] 'process raft request' (duration: 190.05695ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:22.879015Z","caller":"traceutil/trace.go:171","msg":"trace[452108462] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:370; }","duration":"189.321953ms","start":"2026-05-14T07:35:22.689678Z","end":"2026-05-14T07:35:22.879Z","steps":["trace[452108462] 'read index received' (duration: 10.064334ms)","trace[452108462] 'applied index is now lower than readState.Index' (duration: 179.256599ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:22.879245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.573965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-05-14T07:35:22.879321Z","caller":"traceutil/trace.go:171","msg":"trace[347992991] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:361; }","duration":"189.843938ms","start":"2026-05-14T07:35:22.68946Z","end":"2026-05-14T07:35:22.879304Z","steps":["trace[347992991] 'agreement among raft nodes before linearized reading' (duration: 189.723297ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:22.879297Z","caller":"traceutil/trace.go:171","msg":"trace[514959180] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"187.397584ms","start":"2026-05-14T07:35:22.691861Z","end":"2026-05-14T07:35:22.879259Z","steps":["trace[514959180] 'process raft request' (duration: 187.01789ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:22.888052Z","caller":"traceutil/trace.go:171","msg":"trace[1433550487] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"184.153615ms","start":"2026-05-14T07:35:22.703878Z","end":"2026-05-14T07:35:22.888031Z","steps":["trace[1433550487] 'process raft request' (duration: 183.999374ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:22.888462Z","caller":"traceutil/trace.go:171","msg":"trace[680817868] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"183.691931ms","start":"2026-05-14T07:35:22.704741Z","end":"2026-05-14T07:35:22.888433Z","steps":["trace[680817868] 'process raft request' (duration: 183.246627ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:22.888518Z","caller":"traceutil/trace.go:171","msg":"trace[1457830662] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"181.829803ms","start":"2026-05-14T07:35:22.706649Z","end":"2026-05-14T07:35:22.888479Z","steps":["trace[1457830662] 'process raft request' (duration: 181.710732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:22.888529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.491199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-14T07:35:22.888744Z","caller":"traceutil/trace.go:171","msg":"trace[834160387] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:364; }","duration":"196.750471ms","start":"2026-05-14T07:35:22.691981Z","end":"2026-05-14T07:35:22.888732Z","steps":["trace[834160387] 'agreement among raft nodes before linearized reading' (duration: 196.444718ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.21665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.954106ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:35:23.217468Z","caller":"traceutil/trace.go:171","msg":"trace[843866382] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"286.101657ms","start":"2026-05-14T07:35:22.931332Z","end":"2026-05-14T07:35:23.217434Z","steps":["trace[843866382] 'process raft request' (duration: 111.261613ms)","trace[843866382] 'compare' (duration: 173.681823ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:23.217586Z","caller":"traceutil/trace.go:171","msg":"trace[1418327352] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:379; }","duration":"241.961286ms","start":"2026-05-14T07:35:22.975605Z","end":"2026-05-14T07:35:23.217566Z","steps":["trace[1418327352] 'read index received' (duration: 67.138912ms)","trace[1418327352] 'applied index is now lower than readState.Index' (duration: 174.821064ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:23.217927Z","caller":"traceutil/trace.go:171","msg":"trace[1664638594] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"283.019949ms","start":"2026-05-14T07:35:22.934867Z","end":"2026-05-14T07:35:23.217887Z","steps":["trace[1664638594] 'process raft request' (duration: 282.565615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.217967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.342119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-05-14T07:35:23.218024Z","caller":"traceutil/trace.go:171","msg":"trace[977926697] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:369; }","duration":"242.450642ms","start":"2026-05-14T07:35:22.975556Z","end":"2026-05-14T07:35:23.218007Z","steps":["trace[977926697] 'agreement among raft nodes before linearized reading' (duration: 242.262749ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:23.253282Z","caller":"traceutil/trace.go:171","msg":"trace[806698195] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"267.915756ms","start":"2026-05-14T07:35:22.985348Z","end":"2026-05-14T07:35:23.253263Z","steps":["trace[806698195] 'process raft request' (duration: 267.727564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.253362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.506635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"warn","ts":"2026-05-14T07:35:23.253361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.275292ms","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-05-14T07:35:23.253562Z","caller":"traceutil/trace.go:171","msg":"trace[1343091288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:370; }","duration":"131.511104ms","start":"2026-05-14T07:35:23.122032Z","end":"2026-05-14T07:35:23.253543Z","steps":["trace[1343091288] 'agreement among raft nodes before linearized reading' (duration: 131.217531ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:23.253403Z","caller":"traceutil/trace.go:171","msg":"trace[1599757039] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:370; }","duration":"156.621986ms","start":"2026-05-14T07:35:23.096771Z","end":"2026-05-14T07:35:23.253393Z","steps":["trace[1599757039] 'agreement among raft nodes before linearized reading' (duration: 156.526475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.709039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.103251ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:35:23.709285Z","caller":"traceutil/trace.go:171","msg":"trace[956338357] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"487.502741ms","start":"2026-05-14T07:35:23.221738Z","end":"2026-05-14T07:35:23.709241Z","steps":["trace[956338357] 'process raft request' (duration: 161.102797ms)","trace[956338357] 'compare' (duration: 325.872749ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:23.709479Z","caller":"traceutil/trace.go:171","msg":"trace[1338386233] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:382; }","duration":"456.231823ms","start":"2026-05-14T07:35:23.253226Z","end":"2026-05-14T07:35:23.709457Z","steps":["trace[1338386233] 'read index received' (duration: 129.642247ms)","trace[1338386233] 'applied index is now lower than readState.Index' (duration: 326.588196ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:23.709512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:23.221721Z","time spent":"487.691603ms","remote":"127.0.0.1:37976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T07:35:23.709596Z","caller":"traceutil/trace.go:171","msg":"trace[1296526885] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"486.758515ms","start":"2026-05-14T07:35:23.222828Z","end":"2026-05-14T07:35:23.709586Z","steps":["trace[1296526885] 'process raft request' (duration: 486.338221ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.709681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:23.222804Z","time spent":"486.831635ms","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T07:35:23.709933Z","caller":"traceutil/trace.go:171","msg":"trace[2077072292] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"485.374911ms","start":"2026-05-14T07:35:23.224543Z","end":"2026-05-14T07:35:23.709918Z","steps":["trace[2077072292] 'process raft request' (duration: 484.735485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.710014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:23.224528Z","time spent":"485.445132ms","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-14T07:35:23.71019Z","caller":"traceutil/trace.go:171","msg":"trace[1642301195] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"478.986613ms","start":"2026-05-14T07:35:23.231181Z","end":"2026-05-14T07:35:23.710167Z","steps":["trace[1642301195] 'process raft request' (duration: 478.166226ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.710323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:23.231173Z","time spent":"479.078974ms","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:35:23.71023Z","caller":"traceutil/trace.go:171","msg":"trace[15633622] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"485.945866ms","start":"2026-05-14T07:35:23.224244Z","end":"2026-05-14T07:35:23.71019Z","steps":["trace[15633622] 'process raft request' (duration: 484.980658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.710707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:23.224238Z","time spent":"486.3878ms","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T07:35:23.710724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.241611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-05-14T07:35:23.71145Z","caller":"traceutil/trace.go:171","msg":"trace[827240017] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:375; }","duration":"485.964128ms","start":"2026-05-14T07:35:23.225389Z","end":"2026-05-14T07:35:23.711353Z","steps":["trace[827240017] 'agreement among raft nodes before linearized reading' (duration: 484.566374ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:23.712433Z","caller":"traceutil/trace.go:171","msg":"trace[1716738570] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"453.220765ms","start":"2026-05-14T07:35:23.259193Z","end":"2026-05-14T07:35:23.712413Z","steps":["trace[1716738570] 'process raft request' (duration: 452.998343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.712488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.604165ms","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-05-14T07:35:23.712526Z","caller":"traceutil/trace.go:171","msg":"trace[1067106016] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:376; }","duration":"184.652915ms","start":"2026-05-14T07:35:23.527859Z","end":"2026-05-14T07:35:23.712512Z","steps":["trace[1067106016] 'agreement among raft nodes before linearized reading' (duration: 184.509124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.712535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:23.259163Z","time spent":"453.319096ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:35:23.712648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.399757ms","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-05-14T07:35:23.712675Z","caller":"traceutil/trace.go:171","msg":"trace[30485823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:376; }","duration":"191.474977ms","start":"2026-05-14T07:35:23.521192Z","end":"2026-05-14T07:35:23.712667Z","steps":["trace[30485823] 'agreement among raft nodes before linearized reading' (duration: 191.425977ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.712435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.841628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-qfqgw\" ","response":"range_response_count:1 size:4466"} {"level":"info","ts":"2026-05-14T07:35:23.712754Z","caller":"traceutil/trace.go:171","msg":"trace[1789952601] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-qfqgw; range_end:; response_count:1; response_revision:376; }","duration":"457.149371ms","start":"2026-05-14T07:35:23.25555Z","end":"2026-05-14T07:35:23.7127Z","steps":["trace[1789952601] 'agreement among raft nodes before linearized reading' (duration: 456.785557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.712766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.720025ms","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-05-14T07:35:23.712769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:23.225381Z","time spent":"486.162079ms","remote":"127.0.0.1:38332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2925,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"info","ts":"2026-05-14T07:35:23.712796Z","caller":"traceutil/trace.go:171","msg":"trace[1711760662] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:376; }","duration":"224.796315ms","start":"2026-05-14T07:35:23.487991Z","end":"2026-05-14T07:35:23.712787Z","steps":["trace[1711760662] 'agreement among raft nodes before linearized reading' (duration: 224.748885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:23.712842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:23.255535Z","time spent":"457.253661ms","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4490,"request content":"key:\"/registry/pods/kube-system/kube-proxy-qfqgw\" "} {"level":"info","ts":"2026-05-14T07:35:23.913365Z","caller":"traceutil/trace.go:171","msg":"trace[756173068] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"197.251691ms","start":"2026-05-14T07:35:23.716078Z","end":"2026-05-14T07:35:23.91333Z","steps":["trace[756173068] 'process raft request' (duration: 133.528073ms)","trace[756173068] 'compare' (duration: 63.368035ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:23.913684Z","caller":"traceutil/trace.go:171","msg":"trace[1501167345] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"192.614409ms","start":"2026-05-14T07:35:23.720893Z","end":"2026-05-14T07:35:23.913508Z","steps":["trace[1501167345] 'process raft request' (duration: 192.528558ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:23.913753Z","caller":"traceutil/trace.go:171","msg":"trace[466401176] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"195.523255ms","start":"2026-05-14T07:35:23.718218Z","end":"2026-05-14T07:35:23.913741Z","steps":["trace[466401176] 'process raft request' (duration: 195.074591ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:23.913844Z","caller":"traceutil/trace.go:171","msg":"trace[629845379] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"194.560707ms","start":"2026-05-14T07:35:23.719249Z","end":"2026-05-14T07:35:23.913809Z","steps":["trace[629845379] 'process raft request' (duration: 194.097952ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:23.913899Z","caller":"traceutil/trace.go:171","msg":"trace[1229893153] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"195.630556ms","start":"2026-05-14T07:35:23.71817Z","end":"2026-05-14T07:35:23.9138Z","steps":["trace[1229893153] 'process raft request' (duration: 195.038681ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:23.914356Z","caller":"traceutil/trace.go:171","msg":"trace[1029030491] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"193.752838ms","start":"2026-05-14T07:35:23.720584Z","end":"2026-05-14T07:35:23.914337Z","steps":["trace[1029030491] 'process raft request' (duration: 192.80092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:26.120055Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186282939924562,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:35:26.62078Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186282939924562,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:35:27.121848Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186282939924562,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:35:27.622319Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186282939924562,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:35:27.748724Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.184449177s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-14T07:35:27.858446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.285077ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:35:27.858603Z","caller":"traceutil/trace.go:171","msg":"trace[663239888] linearizableReadLoop","detail":"{readStateIndex:403; appliedIndex:402; }","duration":"2.239593602s","start":"2026-05-14T07:35:25.618985Z","end":"2026-05-14T07:35:27.858578Z","steps":["trace[663239888] 'read index received' (duration: 2.129888891s)","trace[663239888] 'applied index is now lower than readState.Index' (duration: 109.702671ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:27.858655Z","caller":"traceutil/trace.go:171","msg":"trace[664579977] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"2.294477711s","start":"2026-05-14T07:35:25.564154Z","end":"2026-05-14T07:35:27.858632Z","steps":["trace[664579977] 'process raft request' (duration: 2.18482138s)","trace[664579977] 'compare' (duration: 109.030625ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:27.858756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:25.564124Z","time spent":"2.294582372s","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:35:27.858757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.239766394s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-qfqgw\" ","response":"range_response_count:1 size:4466"} {"level":"info","ts":"2026-05-14T07:35:27.858828Z","caller":"traceutil/trace.go:171","msg":"trace[38541637] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-qfqgw; range_end:; response_count:1; response_revision:390; }","duration":"2.239878924s","start":"2026-05-14T07:35:25.618932Z","end":"2026-05-14T07:35:27.858811Z","steps":["trace[38541637] 'agreement among raft nodes before linearized reading' (duration: 2.239740123s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:27.858837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.806631832s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T07:35:27.858888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.939507625s","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-05-14T07:35:27.858938Z","caller":"traceutil/trace.go:171","msg":"trace[1337621222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:390; }","duration":"1.939598696s","start":"2026-05-14T07:35:25.919326Z","end":"2026-05-14T07:35:27.858924Z","steps":["trace[1337621222] 'agreement among raft nodes before linearized reading' (duration: 1.939531366s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:27.859049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.082845725s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-14T07:35:27.858836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.939198462s","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-05-14T07:35:27.859109Z","caller":"traceutil/trace.go:171","msg":"trace[1460509326] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:390; }","duration":"1.082930546s","start":"2026-05-14T07:35:26.776155Z","end":"2026-05-14T07:35:27.859086Z","steps":["trace[1460509326] 'agreement among raft nodes before linearized reading' (duration: 1.082839215s)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:27.859126Z","caller":"traceutil/trace.go:171","msg":"trace[688838530] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:390; }","duration":"1.939537726s","start":"2026-05-14T07:35:25.919571Z","end":"2026-05-14T07:35:27.859109Z","steps":["trace[688838530] 'agreement among raft nodes before linearized reading' (duration: 1.939221263s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:27.859154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:26.776134Z","time spent":"1.083011357s","remote":"127.0.0.1:37894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.250\" "} {"level":"warn","ts":"2026-05-14T07:35:27.859186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:25.919536Z","time spent":"1.939638046s","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-14T07:35:27.859039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:25.919296Z","time spent":"1.939722857s","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-14T07:35:27.858941Z","caller":"traceutil/trace.go:171","msg":"trace[358038265] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:390; }","duration":"1.806807263s","start":"2026-05-14T07:35:26.052109Z","end":"2026-05-14T07:35:27.858916Z","steps":["trace[358038265] 'agreement among raft nodes before linearized reading' (duration: 1.806641562s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:27.858888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:25.618913Z","time spent":"2.239963515s","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4490,"request content":"key:\"/registry/pods/kube-system/kube-proxy-qfqgw\" "} {"level":"warn","ts":"2026-05-14T07:35:27.859285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:26.052081Z","time spent":"1.807183127s","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T07:35:27.858961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.939704327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-14T07:35:27.858769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.137953039s","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-05-14T07:35:27.859419Z","caller":"traceutil/trace.go:171","msg":"trace[327649315] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:390; }","duration":"1.940207902s","start":"2026-05-14T07:35:25.919202Z","end":"2026-05-14T07:35:27.85941Z","steps":["trace[327649315] 'agreement among raft nodes before linearized reading' (duration: 1.939715597s)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:27.859431Z","caller":"traceutil/trace.go:171","msg":"trace[1894832307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:390; }","duration":"2.138663905s","start":"2026-05-14T07:35:25.720756Z","end":"2026-05-14T07:35:27.85942Z","steps":["trace[1894832307] 'agreement among raft nodes before linearized reading' (duration: 2.137959028s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:27.85946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:25.91918Z","time spent":"1.940270132s","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-14T07:35:27.859465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:25.720654Z","time spent":"2.138801206s","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-14T07:35:28.018089Z","caller":"traceutil/trace.go:171","msg":"trace[1906123918] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"154.395011ms","start":"2026-05-14T07:35:27.863657Z","end":"2026-05-14T07:35:28.018052Z","steps":["trace[1906123918] 'process raft request' (duration: 154.016077ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:28.018833Z","caller":"traceutil/trace.go:171","msg":"trace[586325823] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"153.485422ms","start":"2026-05-14T07:35:27.865329Z","end":"2026-05-14T07:35:28.018815Z","steps":["trace[586325823] 'process raft request' (duration: 153.021668ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:28.019286Z","caller":"traceutil/trace.go:171","msg":"trace[340810552] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"153.869065ms","start":"2026-05-14T07:35:27.86537Z","end":"2026-05-14T07:35:28.019239Z","steps":["trace[340810552] 'process raft request' (duration: 153.383751ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:28.019614Z","caller":"traceutil/trace.go:171","msg":"trace[769787715] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"153.30347ms","start":"2026-05-14T07:35:27.865093Z","end":"2026-05-14T07:35:28.018396Z","steps":["trace[769787715] 'process raft request' (duration: 152.876817ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:28.019637Z","caller":"traceutil/trace.go:171","msg":"trace[40683170] linearizableReadLoop","detail":"{readStateIndex:408; appliedIndex:403; }","duration":"151.334223ms","start":"2026-05-14T07:35:27.868279Z","end":"2026-05-14T07:35:28.019613Z","steps":["trace[40683170] 'read index received' (duration: 101.619369ms)","trace[40683170] 'applied index is now lower than readState.Index' (duration: 49.713574ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:28.019805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.504164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:35:28.019838Z","caller":"traceutil/trace.go:171","msg":"trace[1065262232] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:395; }","duration":"151.553595ms","start":"2026-05-14T07:35:27.868274Z","end":"2026-05-14T07:35:28.019828Z","steps":["trace[1065262232] 'agreement among raft nodes before linearized reading' (duration: 151.439284ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:28.020045Z","caller":"traceutil/trace.go:171","msg":"trace[265189633] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"150.099443ms","start":"2026-05-14T07:35:27.869933Z","end":"2026-05-14T07:35:28.020033Z","steps":["trace[265189633] 'process raft request' (duration: 149.076643ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:28.202876Z","caller":"traceutil/trace.go:171","msg":"trace[1794415872] linearizableReadLoop","detail":"{readStateIndex:410; appliedIndex:409; }","duration":"181.565563ms","start":"2026-05-14T07:35:28.021269Z","end":"2026-05-14T07:35:28.202835Z","steps":["trace[1794415872] 'read index received' (duration: 181.299931ms)","trace[1794415872] 'applied index is now lower than readState.Index' (duration: 264.272µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:28.202947Z","caller":"traceutil/trace.go:171","msg":"trace[1821094422] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"223.219175ms","start":"2026-05-14T07:35:27.979672Z","end":"2026-05-14T07:35:28.202891Z","steps":["trace[1821094422] 'process raft request' (duration: 222.924352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:28.203162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.856155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:35:28.203262Z","caller":"traceutil/trace.go:171","msg":"trace[627753924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:396; }","duration":"182.010636ms","start":"2026-05-14T07:35:28.021225Z","end":"2026-05-14T07:35:28.203236Z","steps":["trace[627753924] 'agreement among raft nodes before linearized reading' (duration: 181.762734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:28.203669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.550938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-05-14T07:35:28.203699Z","caller":"traceutil/trace.go:171","msg":"trace[93226098] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"168.843979ms","start":"2026-05-14T07:35:28.034845Z","end":"2026-05-14T07:35:28.203689Z","steps":["trace[93226098] 'process raft request' (duration: 168.583617ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:28.203732Z","caller":"traceutil/trace.go:171","msg":"trace[202832019] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:397; }","duration":"176.67259ms","start":"2026-05-14T07:35:28.027047Z","end":"2026-05-14T07:35:28.20372Z","steps":["trace[202832019] 'agreement among raft nodes before linearized reading' (duration: 176.506678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:28.742925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.70945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-05-14T07:35:28.743031Z","caller":"traceutil/trace.go:171","msg":"trace[930945916] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:401; }","duration":"114.897731ms","start":"2026-05-14T07:35:28.62811Z","end":"2026-05-14T07:35:28.743008Z","steps":["trace[930945916] 'range keys from in-memory index tree' (duration: 114.565798ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:36.191436Z","caller":"traceutil/trace.go:171","msg":"trace[1562624414] linearizableReadLoop","detail":"{readStateIndex:434; appliedIndex:433; }","duration":"170.295405ms","start":"2026-05-14T07:35:36.021109Z","end":"2026-05-14T07:35:36.191404Z","steps":["trace[1562624414] 'read index received' (duration: 170.210724ms)","trace[1562624414] 'applied index is now lower than readState.Index' (duration: 83.021µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:36.1916Z","caller":"traceutil/trace.go:171","msg":"trace[1242297937] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"183.803969ms","start":"2026-05-14T07:35:36.007746Z","end":"2026-05-14T07:35:36.19155Z","steps":["trace[1242297937] 'process raft request' (duration: 183.473126ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:36.191654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.251736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-14T07:35:36.192153Z","caller":"traceutil/trace.go:171","msg":"trace[1157469925] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"131.826931ms","start":"2026-05-14T07:35:36.060311Z","end":"2026-05-14T07:35:36.192138Z","steps":["trace[1157469925] 'agreement among raft nodes before linearized reading' (duration: 131.271606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:36.191687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.530816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:35:36.19232Z","caller":"traceutil/trace.go:171","msg":"trace[1911146940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:419; }","duration":"171.202733ms","start":"2026-05-14T07:35:36.021083Z","end":"2026-05-14T07:35:36.192286Z","steps":["trace[1911146940] 'agreement among raft nodes before linearized reading' (duration: 170.481997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:36.191731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.115439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-14T07:35:36.191803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.146146ms","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-05-14T07:35:36.192493Z","caller":"traceutil/trace.go:171","msg":"trace[2076161496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:419; }","duration":"116.867505ms","start":"2026-05-14T07:35:36.075568Z","end":"2026-05-14T07:35:36.192435Z","steps":["trace[2076161496] 'agreement among raft nodes before linearized reading' (duration: 116.114079ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:36.192599Z","caller":"traceutil/trace.go:171","msg":"trace[351116124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:419; }","duration":"111.984193ms","start":"2026-05-14T07:35:36.080589Z","end":"2026-05-14T07:35:36.192574Z","steps":["trace[351116124] 'agreement among raft nodes before linearized reading' (duration: 111.072986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:36.191976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.414181ms","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-05-14T07:35:36.192702Z","caller":"traceutil/trace.go:171","msg":"trace[1222276781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:419; }","duration":"117.152277ms","start":"2026-05-14T07:35:36.075516Z","end":"2026-05-14T07:35:36.192669Z","steps":["trace[1222276781] 'agreement among raft nodes before linearized reading' (duration: 116.230999ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:42.343185Z","caller":"traceutil/trace.go:171","msg":"trace[220994327] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"110.095248ms","start":"2026-05-14T07:35:42.233059Z","end":"2026-05-14T07:35:42.343154Z","steps":["trace[220994327] 'process raft request' (duration: 109.913357ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:42.343518Z","caller":"traceutil/trace.go:171","msg":"trace[426773228] linearizableReadLoop","detail":"{readStateIndex:479; appliedIndex:479; }","duration":"110.33845ms","start":"2026-05-14T07:35:42.233139Z","end":"2026-05-14T07:35:42.343478Z","steps":["trace[426773228] 'read index received' (duration: 110.33024ms)","trace[426773228] 'applied index is now lower than readState.Index' (duration: 6.86µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:42.343722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.548351ms","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-05-14T07:35:42.343776Z","caller":"traceutil/trace.go:171","msg":"trace[2136836114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:463; }","duration":"110.661643ms","start":"2026-05-14T07:35:42.233096Z","end":"2026-05-14T07:35:42.343758Z","steps":["trace[2136836114] 'agreement among raft nodes before linearized reading' (duration: 110.531222ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:42.715595Z","caller":"traceutil/trace.go:171","msg":"trace[1807138705] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"481.780637ms","start":"2026-05-14T07:35:42.233787Z","end":"2026-05-14T07:35:42.715568Z","steps":["trace[1807138705] 'process raft request' (duration: 481.681707ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:42.715601Z","caller":"traceutil/trace.go:171","msg":"trace[865145436] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"482.279512ms","start":"2026-05-14T07:35:42.233272Z","end":"2026-05-14T07:35:42.715552Z","steps":["trace[865145436] 'process raft request' (duration: 475.363216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:42.71576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:42.233774Z","time spent":"481.897818ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:35:42.715856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:42.23322Z","time spent":"482.487224ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:35:42.71597Z","caller":"traceutil/trace.go:171","msg":"trace[1799431515] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"365.590451ms","start":"2026-05-14T07:35:42.350296Z","end":"2026-05-14T07:35:42.715887Z","steps":["trace[1799431515] 'process raft request' (duration: 365.233718ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:42.716335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:42.350261Z","time spent":"365.839033ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:35:50.001214Z","caller":"traceutil/trace.go:171","msg":"trace[442666408] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"260.872309ms","start":"2026-05-14T07:35:49.740319Z","end":"2026-05-14T07:35:50.001192Z","steps":["trace[442666408] 'process raft request' (duration: 260.731248ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.01227Z","caller":"traceutil/trace.go:171","msg":"trace[1722329454] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"266.279221ms","start":"2026-05-14T07:35:49.745971Z","end":"2026-05-14T07:35:50.012251Z","steps":["trace[1722329454] 'process raft request' (duration: 265.932839ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.012546Z","caller":"traceutil/trace.go:171","msg":"trace[147676515] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"254.8888ms","start":"2026-05-14T07:35:49.757648Z","end":"2026-05-14T07:35:50.012537Z","steps":["trace[147676515] 'process raft request' (duration: 254.544298ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.01271Z","caller":"traceutil/trace.go:171","msg":"trace[1473745826] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"262.181288ms","start":"2026-05-14T07:35:49.750515Z","end":"2026-05-14T07:35:50.012697Z","steps":["trace[1473745826] 'process raft request' (duration: 261.556263ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.012676Z","caller":"traceutil/trace.go:171","msg":"trace[1397194098] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"254.479597ms","start":"2026-05-14T07:35:49.758142Z","end":"2026-05-14T07:35:50.012621Z","steps":["trace[1397194098] 'process raft request' (duration: 254.103094ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.012798Z","caller":"traceutil/trace.go:171","msg":"trace[2086382078] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"255.804028ms","start":"2026-05-14T07:35:49.756988Z","end":"2026-05-14T07:35:50.012792Z","steps":["trace[2086382078] 'process raft request' (duration: 255.145902ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.012905Z","caller":"traceutil/trace.go:171","msg":"trace[1786900182] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"251.847017ms","start":"2026-05-14T07:35:49.761046Z","end":"2026-05-14T07:35:50.012893Z","steps":["trace[1786900182] 'process raft request' (duration: 251.237712ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.013219Z","caller":"traceutil/trace.go:171","msg":"trace[1129100775] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"251.805846ms","start":"2026-05-14T07:35:49.761385Z","end":"2026-05-14T07:35:50.01319Z","steps":["trace[1129100775] 'process raft request' (duration: 250.973549ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.013531Z","caller":"traceutil/trace.go:171","msg":"trace[1599784353] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"222.480056ms","start":"2026-05-14T07:35:49.791038Z","end":"2026-05-14T07:35:50.013518Z","steps":["trace[1599784353] 'process raft request' (duration: 222.167663ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.013622Z","caller":"traceutil/trace.go:171","msg":"trace[2105392017] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"239.521201ms","start":"2026-05-14T07:35:49.774092Z","end":"2026-05-14T07:35:50.013613Z","steps":["trace[2105392017] 'process raft request' (duration: 239.036467ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.013676Z","caller":"traceutil/trace.go:171","msg":"trace[922067418] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"218.725825ms","start":"2026-05-14T07:35:49.794938Z","end":"2026-05-14T07:35:50.013664Z","steps":["trace[922067418] 'process raft request' (duration: 218.333272ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:50.013746Z","caller":"traceutil/trace.go:171","msg":"trace[357108478] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"194.277152ms","start":"2026-05-14T07:35:49.819461Z","end":"2026-05-14T07:35:50.013739Z","steps":["trace[357108478] 'process raft request' (duration: 193.9011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:56.918663Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186282939925046,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:35:57.491315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.132384ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:35:57.491539Z","caller":"traceutil/trace.go:171","msg":"trace[428796578] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"1.073612623s","start":"2026-05-14T07:35:56.417906Z","end":"2026-05-14T07:35:57.491519Z","steps":["trace[428796578] 'read index received' (duration: 831.758684ms)","trace[428796578] 'applied index is now lower than readState.Index' (duration: 241.852349ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:35:57.491621Z","caller":"traceutil/trace.go:171","msg":"trace[1453355767] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.150959483s","start":"2026-05-14T07:35:56.340593Z","end":"2026-05-14T07:35:57.491553Z","steps":["trace[1453355767] 'process raft request' (duration: 909.491823ms)","trace[1453355767] 'compare' (duration: 240.18795ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:57.491903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:56.34055Z","time spent":"1.151209545s","remote":"127.0.0.1:37968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:35:57.492021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.965039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:35:57.492091Z","caller":"traceutil/trace.go:171","msg":"trace[922308399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"470.068465ms","start":"2026-05-14T07:35:57.022003Z","end":"2026-05-14T07:35:57.492071Z","steps":["trace[922308399] 'agreement among raft nodes before linearized reading' (duration: 469.957489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:57.492136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:57.021982Z","time spent":"470.144818ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T07:35:57.492151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.667879ms","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-05-14T07:35:57.49222Z","caller":"traceutil/trace.go:171","msg":"trace[202268547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"559.774114ms","start":"2026-05-14T07:35:56.932437Z","end":"2026-05-14T07:35:57.492211Z","steps":["trace[202268547] 'agreement among raft nodes before linearized reading' (duration: 559.457439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:57.492075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074141348s","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-05-14T07:35:57.492269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:56.932419Z","time spent":"559.842116ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-14T07:35:57.492302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.644525ms","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-05-14T07:35:57.492362Z","caller":"traceutil/trace.go:171","msg":"trace[1719575567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"1.074436282s","start":"2026-05-14T07:35:56.417855Z","end":"2026-05-14T07:35:57.492291Z","steps":["trace[1719575567] 'agreement among raft nodes before linearized reading' (duration: 1.073926538s)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:57.492397Z","caller":"traceutil/trace.go:171","msg":"trace[1203728710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"504.773701ms","start":"2026-05-14T07:35:56.98759Z","end":"2026-05-14T07:35:57.492364Z","steps":["trace[1203728710] 'agreement among raft nodes before linearized reading' (duration: 504.607033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:57.492469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:56.987569Z","time spent":"504.882577ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-14T07:35:57.492474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:56.41783Z","time spent":"1.074607971s","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-14T07:35:57.492132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.75778ms","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-05-14T07:35:57.492573Z","caller":"traceutil/trace.go:171","msg":"trace[869368180] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"505.238984ms","start":"2026-05-14T07:35:56.987304Z","end":"2026-05-14T07:35:57.492543Z","steps":["trace[869368180] 'agreement among raft nodes before linearized reading' (duration: 504.572921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:57.492647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:56.98729Z","time spent":"505.338749ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-14T07:35:57.492231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.504194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-14T07:35:57.492772Z","caller":"traceutil/trace.go:171","msg":"trace[473030610] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:620; }","duration":"715.065462ms","start":"2026-05-14T07:35:56.777671Z","end":"2026-05-14T07:35:57.492736Z","steps":["trace[473030610] 'agreement among raft nodes before linearized reading' (duration: 714.395589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:57.492846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:56.777616Z","time spent":"715.193478ms","remote":"127.0.0.1:37894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.250\" "} {"level":"warn","ts":"2026-05-14T07:35:57.492133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.792124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dqzxr\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-14T07:35:57.493252Z","caller":"traceutil/trace.go:171","msg":"trace[157882] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dqzxr; range_end:; response_count:1; response_revision:620; }","duration":"782.986191ms","start":"2026-05-14T07:35:56.710256Z","end":"2026-05-14T07:35:57.493242Z","steps":["trace[157882] 'agreement among raft nodes before linearized reading' (duration: 781.624227ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:57.493311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:56.710239Z","time spent":"783.061375ms","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-dqzxr\" "} {"level":"warn","ts":"2026-05-14T07:35:58.417087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.767491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:35:58.417578Z","caller":"traceutil/trace.go:171","msg":"trace[1654119228] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"837.960054ms","start":"2026-05-14T07:35:57.579598Z","end":"2026-05-14T07:35:58.417558Z","steps":["trace[1654119228] 'process raft request' (duration: 837.918243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:58.417673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:57.579575Z","time spent":"838.06712ms","remote":"127.0.0.1:37894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:35:58.417872Z","caller":"traceutil/trace.go:171","msg":"trace[1458508603] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"917.886192ms","start":"2026-05-14T07:35:57.499975Z","end":"2026-05-14T07:35:58.417861Z","steps":["trace[1458508603] 'process raft request' (duration: 157.258792ms)","trace[1458508603] 'compare' (duration: 759.593542ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:35:58.417957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:57.499941Z","time spent":"917.989137ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:35:58.418255Z","caller":"traceutil/trace.go:171","msg":"trace[1100578937] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"917.784037ms","start":"2026-05-14T07:35:57.50046Z","end":"2026-05-14T07:35:58.418245Z","steps":["trace[1100578937] 'process raft request' (duration: 916.813132ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:58.418336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:57.500426Z","time spent":"917.881852ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:35:58.418466Z","caller":"traceutil/trace.go:171","msg":"trace[1471330507] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"917.335215ms","start":"2026-05-14T07:35:57.501123Z","end":"2026-05-14T07:35:58.418458Z","steps":["trace[1471330507] 'process raft request' (duration: 916.211263ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:35:58.418677Z","caller":"traceutil/trace.go:171","msg":"trace[1091031269] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"864.531837ms","start":"2026-05-14T07:35:57.553948Z","end":"2026-05-14T07:35:58.418479Z","steps":["trace[1091031269] 'process raft request' (duration: 863.52283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:58.419196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:57.501092Z","time spent":"918.001505ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:35:58.418756Z","caller":"traceutil/trace.go:171","msg":"trace[1189904182] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"915.770502ms","start":"2026-05-14T07:35:57.502972Z","end":"2026-05-14T07:35:58.418743Z","steps":["trace[1189904182] 'process raft request' (duration: 914.399609ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:58.419415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:57.50295Z","time spent":"916.418562ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:35:58.418963Z","caller":"traceutil/trace.go:171","msg":"trace[727414985] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"909.073576ms","start":"2026-05-14T07:35:57.509878Z","end":"2026-05-14T07:35:58.418951Z","steps":["trace[727414985] 'process raft request' (duration: 907.540605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:35:58.419516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:57.553904Z","time spent":"865.316783ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-14T07:35:58.420229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:57.509862Z","time spent":"910.311353ms","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:35:59.522324Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186282939925063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:36:00.023017Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186282939925063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:36:00.321217Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.510100078s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T07:36:00.361488Z","caller":"traceutil/trace.go:171","msg":"trace[1733230868] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.550482726s","start":"2026-05-14T07:35:58.810981Z","end":"2026-05-14T07:36:00.361463Z","steps":["trace[1733230868] 'process raft request' (duration: 1.51165399s)","trace[1733230868] 'compare' (duration: 38.226938ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:36:00.36163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:58.810946Z","time spent":"1.550598661s","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:36:00.37933Z","caller":"traceutil/trace.go:171","msg":"trace[986069915] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.53168622s","start":"2026-05-14T07:35:58.847618Z","end":"2026-05-14T07:36:00.379304Z","steps":["trace[986069915] 'process raft request' (duration: 1.531082373s)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:36:00.379436Z","caller":"traceutil/trace.go:171","msg":"trace[1726578541] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"1.357575031s","start":"2026-05-14T07:35:59.021844Z","end":"2026-05-14T07:36:00.379419Z","steps":["trace[1726578541] 'read index received' (duration: 1.300470804s)","trace[1726578541] 'applied index is now lower than readState.Index' (duration: 57.101407ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:36:00.379501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:58.847535Z","time spent":"1.531872719s","remote":"127.0.0.1:37968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:36:00.379537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.357687467s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:36:00.379563Z","caller":"traceutil/trace.go:171","msg":"trace[1179561157] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"1.35776908s","start":"2026-05-14T07:35:59.021786Z","end":"2026-05-14T07:36:00.379555Z","steps":["trace[1179561157] 'agreement among raft nodes before linearized reading' (duration: 1.357681697s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:00.37959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:35:59.021753Z","time spent":"1.357833313s","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-14T07:36:02.125242Z","caller":"traceutil/trace.go:171","msg":"trace[1179969689] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:688; }","duration":"103.590233ms","start":"2026-05-14T07:36:02.02162Z","end":"2026-05-14T07:36:02.125211Z","steps":["trace[1179969689] 'read index received' (duration: 103.353332ms)","trace[1179969689] 'applied index is now lower than readState.Index' (duration: 235.831µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:36:02.125354Z","caller":"traceutil/trace.go:171","msg":"trace[6263219] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"233.458781ms","start":"2026-05-14T07:36:01.891866Z","end":"2026-05-14T07:36:02.125325Z","steps":["trace[6263219] 'process raft request' (duration: 233.199169ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:02.125458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.928968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:36:02.125518Z","caller":"traceutil/trace.go:171","msg":"trace[1770676390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:665; }","duration":"104.061934ms","start":"2026-05-14T07:36:02.021442Z","end":"2026-05-14T07:36:02.125504Z","steps":["trace[1770676390] 'agreement among raft nodes before linearized reading' (duration: 103.915087ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:36:13.074784Z","caller":"traceutil/trace.go:171","msg":"trace[452530848] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"577.989909ms","start":"2026-05-14T07:36:12.496762Z","end":"2026-05-14T07:36:13.074752Z","steps":["trace[452530848] 'process raft request' (duration: 577.802362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:13.075049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:36:12.496731Z","time spent":"578.148405ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:36:13.193857Z","caller":"traceutil/trace.go:171","msg":"trace[1569171223] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"693.764664ms","start":"2026-05-14T07:36:12.500073Z","end":"2026-05-14T07:36:13.193838Z","steps":["trace[1569171223] 'process raft request' (duration: 692.549277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:13.193965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:36:12.500058Z","time spent":"693.853418ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:36:13.194124Z","caller":"traceutil/trace.go:171","msg":"trace[1198961675] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"693.861578ms","start":"2026-05-14T07:36:12.500224Z","end":"2026-05-14T07:36:13.194085Z","steps":["trace[1198961675] 'process raft request' (duration: 693.566656ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:36:13.194305Z","caller":"traceutil/trace.go:171","msg":"trace[1263783506] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"693.747514ms","start":"2026-05-14T07:36:12.500536Z","end":"2026-05-14T07:36:13.194284Z","steps":["trace[1263783506] 'process raft request' (duration: 693.454982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:13.194374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:36:12.500218Z","time spent":"694.022504ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:36:13.194622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:36:12.500522Z","time spent":"693.991683ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:36:13.366776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.503332ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-14T07:36:13.366914Z","caller":"traceutil/trace.go:171","msg":"trace[1572580470] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:799; }","duration":"344.685621ms","start":"2026-05-14T07:36:13.022202Z","end":"2026-05-14T07:36:13.366888Z","steps":["trace[1572580470] 'read index received' (duration: 52.369653ms)","trace[1572580470] 'applied index is now lower than readState.Index' (duration: 292.314288ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:36:13.367008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.802225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:36:13.367036Z","caller":"traceutil/trace.go:171","msg":"trace[221721635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:776; }","duration":"344.892319ms","start":"2026-05-14T07:36:13.022133Z","end":"2026-05-14T07:36:13.367025Z","steps":["trace[221721635] 'agreement among raft nodes before linearized reading' (duration: 344.817566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:13.367076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:36:13.022109Z","time spent":"344.958372ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T07:36:16.330964Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186282939925371,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:36:16.83161Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186282939925371,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:36:16.894726Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.097437281s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T07:36:16.895184Z","caller":"traceutil/trace.go:171","msg":"trace[1496733224] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:817; }","duration":"1.064775481s","start":"2026-05-14T07:36:15.830381Z","end":"2026-05-14T07:36:16.895157Z","steps":["trace[1496733224] 'read index received' (duration: 1.064594523s)","trace[1496733224] 'applied index is now lower than readState.Index' (duration: 179.758µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:36:16.895388Z","caller":"traceutil/trace.go:171","msg":"trace[1004689162] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"1.098222032s","start":"2026-05-14T07:36:15.797134Z","end":"2026-05-14T07:36:16.895356Z","steps":["trace[1004689162] 'process raft request' (duration: 1.097853147s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:16.895488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065075452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-g7958\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-05-14T07:36:16.895481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.754783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:36:16.895555Z","caller":"traceutil/trace.go:171","msg":"trace[1171241526] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-g7958; range_end:; response_count:1; response_revision:790; }","duration":"1.065218047s","start":"2026-05-14T07:36:15.830322Z","end":"2026-05-14T07:36:16.89554Z","steps":["trace[1171241526] 'agreement among raft nodes before linearized reading' (duration: 1.065003209s)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:36:16.895575Z","caller":"traceutil/trace.go:171","msg":"trace[1956971982] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"873.91554ms","start":"2026-05-14T07:36:16.021643Z","end":"2026-05-14T07:36:16.895559Z","steps":["trace[1956971982] 'agreement among raft nodes before linearized reading' (duration: 873.748904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:16.895596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:36:15.830294Z","time spent":"1.06529358s","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-g7958\" "} {"level":"warn","ts":"2026-05-14T07:36:16.895615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:36:16.021618Z","time spent":"873.988993ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-14T07:36:16.89576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.027365ms","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":"warn","ts":"2026-05-14T07:36:16.896073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:36:15.797101Z","time spent":"1.098401659s","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:36:16.896109Z","caller":"traceutil/trace.go:171","msg":"trace[1835848154] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:790; }","duration":"527.236323ms","start":"2026-05-14T07:36:16.368613Z","end":"2026-05-14T07:36:16.89585Z","steps":["trace[1835848154] 'agreement among raft nodes before linearized reading' (duration: 526.963572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:16.896424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.757606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-14T07:36:16.896498Z","caller":"traceutil/trace.go:171","msg":"trace[1187145069] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:790; }","duration":"117.86843ms","start":"2026-05-14T07:36:16.77859Z","end":"2026-05-14T07:36:16.896458Z","steps":["trace[1187145069] 'agreement among raft nodes before linearized reading' (duration: 117.60465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:16.896446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:36:16.368586Z","time spent":"527.839065ms","remote":"127.0.0.1:37952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-05-14T07:36:17.167367Z","caller":"traceutil/trace.go:171","msg":"trace[1927971313] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:818; }","duration":"144.810962ms","start":"2026-05-14T07:36:17.022535Z","end":"2026-05-14T07:36:17.167346Z","steps":["trace[1927971313] 'read index received' (duration: 126.803126ms)","trace[1927971313] 'applied index is now lower than readState.Index' (duration: 18.006656ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:36:17.167491Z","caller":"traceutil/trace.go:171","msg":"trace[1164854170] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"264.027015ms","start":"2026-05-14T07:36:16.903453Z","end":"2026-05-14T07:36:17.16748Z","steps":["trace[1164854170] 'process raft request' (duration: 263.753835ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:17.167712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.148805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:36:17.167916Z","caller":"traceutil/trace.go:171","msg":"trace[1780442541] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:791; }","duration":"145.406474ms","start":"2026-05-14T07:36:17.022468Z","end":"2026-05-14T07:36:17.167875Z","steps":["trace[1780442541] 'agreement among raft nodes before linearized reading' (duration: 145.146314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:31.665915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.360212ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:36:31.666493Z","caller":"traceutil/trace.go:171","msg":"trace[576426497] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:954; }","duration":"161.974112ms","start":"2026-05-14T07:36:31.504499Z","end":"2026-05-14T07:36:31.666474Z","steps":["trace[576426497] 'range keys from in-memory index tree' (duration: 161.342012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:31.66606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.020857ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:36:31.666716Z","caller":"traceutil/trace.go:171","msg":"trace[1949220467] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"298.769989ms","start":"2026-05-14T07:36:31.367879Z","end":"2026-05-14T07:36:31.666648Z","steps":["trace[1949220467] 'process raft request' (duration: 143.083411ms)","trace[1949220467] 'compare' (duration: 154.463229ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:36:31.758037Z","caller":"traceutil/trace.go:171","msg":"trace[802862505] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"389.876638ms","start":"2026-05-14T07:36:31.36813Z","end":"2026-05-14T07:36:31.758007Z","steps":["trace[802862505] 'process raft request' (duration: 389.702833ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:36:31.758237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:36:31.368101Z","time spent":"390.024933ms","remote":"127.0.0.1:38310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5626,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:36:31.816375Z","caller":"traceutil/trace.go:171","msg":"trace[1988099650] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"143.820515ms","start":"2026-05-14T07:36:31.672523Z","end":"2026-05-14T07:36:31.816344Z","steps":["trace[1988099650] 'process raft request' (duration: 132.22441ms)","trace[1988099650] 'compare' (duration: 11.483521ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:36:57.680938Z","caller":"traceutil/trace.go:171","msg":"trace[1042512494] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"144.682ms","start":"2026-05-14T07:36:57.536213Z","end":"2026-05-14T07:36:57.680895Z","steps":["trace[1042512494] 'process raft request' (duration: 96.643661ms)","trace[1042512494] 'compare' (duration: 47.771842ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:36:57.680866Z","caller":"traceutil/trace.go:171","msg":"trace[62063889] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"144.014063ms","start":"2026-05-14T07:36:57.536825Z","end":"2026-05-14T07:36:57.680839Z","steps":["trace[62063889] 'process raft request' (duration: 143.950881ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:37:17.959104Z","caller":"traceutil/trace.go:171","msg":"trace[749189731] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"107.717138ms","start":"2026-05-14T07:37:17.851358Z","end":"2026-05-14T07:37:17.959075Z","steps":["trace[749189731] 'process raft request' (duration: 107.559664ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:37:17.961889Z","caller":"traceutil/trace.go:171","msg":"trace[1884551228] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"109.973007ms","start":"2026-05-14T07:37:17.85189Z","end":"2026-05-14T07:37:17.961863Z","steps":["trace[1884551228] 'process raft request' (duration: 109.471527ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:37:44.099404Z","caller":"traceutil/trace.go:171","msg":"trace[2050219899] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"153.518718ms","start":"2026-05-14T07:37:43.945863Z","end":"2026-05-14T07:37:44.099382Z","steps":["trace[2050219899] 'process raft request' (duration: 57.136091ms)","trace[2050219899] 'compare' (duration: 96.180202ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:37:44.371341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.143301ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:37:44.371485Z","caller":"traceutil/trace.go:171","msg":"trace[363892078] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"192.04ms","start":"2026-05-14T07:37:44.179422Z","end":"2026-05-14T07:37:44.371462Z","steps":["trace[363892078] 'process raft request' (duration: 25.671195ms)","trace[363892078] 'compare' (duration: 165.995429ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:37:44.537154Z","caller":"traceutil/trace.go:171","msg":"trace[2095967705] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"120.353221ms","start":"2026-05-14T07:37:44.416767Z","end":"2026-05-14T07:37:44.537121Z","steps":["trace[2095967705] 'process raft request' (duration: 107.478487ms)","trace[2095967705] 'compare' (duration: 12.751442ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:38:04.989443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.435457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-14T07:38:04.989546Z","caller":"traceutil/trace.go:171","msg":"trace[2114873778] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1309; }","duration":"423.60164ms","start":"2026-05-14T07:38:04.56592Z","end":"2026-05-14T07:38:04.989522Z","steps":["trace[2114873778] 'count revisions from in-memory index tree' (duration: 423.333485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:38:04.989591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:38:04.565898Z","time spent":"423.682511ms","remote":"127.0.0.1:37912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":31,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"info","ts":"2026-05-14T07:38:04.989906Z","caller":"traceutil/trace.go:171","msg":"trace[672897016] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"384.978889ms","start":"2026-05-14T07:38:04.604894Z","end":"2026-05-14T07:38:04.989873Z","steps":["trace[672897016] 'process raft request' (duration: 384.831457ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:38:04.990102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:38:04.604874Z","time spent":"385.129411ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:38:13.865904Z","caller":"traceutil/trace.go:171","msg":"trace[1073388982] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"161.223931ms","start":"2026-05-14T07:38:13.704654Z","end":"2026-05-14T07:38:13.865877Z","steps":["trace[1073388982] 'process raft request' (duration: 161.019678ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:38:14.384008Z","caller":"traceutil/trace.go:171","msg":"trace[1502111185] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"131.071029ms","start":"2026-05-14T07:38:14.252869Z","end":"2026-05-14T07:38:14.38394Z","steps":["trace[1502111185] 'process raft request' (duration: 130.702374ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:38:14.869364Z","caller":"traceutil/trace.go:171","msg":"trace[152283765] linearizableReadLoop","detail":"{readStateIndex:1404; appliedIndex:1403; }","duration":"353.393514ms","start":"2026-05-14T07:38:14.51594Z","end":"2026-05-14T07:38:14.869333Z","steps":["trace[152283765] 'read index received' (duration: 334.885025ms)","trace[152283765] 'applied index is now lower than readState.Index' (duration: 18.506889ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:38:14.869722Z","caller":"traceutil/trace.go:171","msg":"trace[1574146773] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"480.944398ms","start":"2026-05-14T07:38:14.388741Z","end":"2026-05-14T07:38:14.869685Z","steps":["trace[1574146773] 'process raft request' (duration: 461.87604ms)","trace[1574146773] 'compare' (duration: 17.97732ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:38:14.869888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:38:14.388707Z","time spent":"481.093601ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:38:14.870254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.292078ms","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-05-14T07:38:14.870345Z","caller":"traceutil/trace.go:171","msg":"trace[792995299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1347; }","duration":"354.451251ms","start":"2026-05-14T07:38:14.515873Z","end":"2026-05-14T07:38:14.870325Z","steps":["trace[792995299] 'agreement among raft nodes before linearized reading' (duration: 353.568247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:38:14.870393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:38:14.515851Z","time spent":"354.531602ms","remote":"127.0.0.1:38128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}