{"level":"warn","ts":"2026-05-29T13:56:06.849793Z","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-29T13:56:06.849932Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129: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.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-29T13:56:06.850065Z","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-29T13:56:06.850115Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-05-29T13:56:06.850174Z","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-29T13:56:06.851347Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-05-29T13:56:06.851514Z","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.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-29T13:56:06.860488Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.515175ms"} {"level":"info","ts":"2026-05-29T13:56:06.873215Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-05-29T13:56:06.873396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-05-29T13:56:06.873492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-05-29T13:56:06.873549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-29T13:56:06.873597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-05-29T13:56:06.873687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-05-29T13:56:06.883024Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-29T13:56:06.890175Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-29T13:56:06.891957Z","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-29T13:56:06.894444Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-29T13:56:06.89464Z","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-29T13:56:06.894809Z","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-29T13:56:06.894827Z","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-29T13:56:06.895092Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-29T13:56:06.903825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-05-29T13:56:06.905694Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-05-29T13:56:06.907048Z","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-29T13:56:06.907134Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-05-29T13:56:06.907166Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-05-29T13:56:06.907393Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-29T13:56:06.907436Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-29T13:56:07.474899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-05-29T13:56:07.474976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-05-29T13:56:07.475027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-05-29T13:56:07.475051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-05-29T13:56:07.475066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-05-29T13:56:07.475085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-05-29T13:56:07.4751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-05-29T13:56:07.476092Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T13:56:07.479662Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T13:56:07.479655Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-05-29T13:56:07.479705Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T13:56:07.480185Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-29T13:56:07.480296Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-29T13:56:07.482091Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-29T13:56:07.485352Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T13:56:07.485439Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T13:56:07.485472Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T13:56:07.486484Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"warn","ts":"2026-05-29T13:56:07.73209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.79984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:07.73222Z","caller":"traceutil/trace.go:171","msg":"trace[573458365] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"131.011302ms","start":"2026-05-29T13:56:07.601187Z","end":"2026-05-29T13:56:07.732198Z","steps":["trace[573458365] 'count revisions from in-memory index tree' (duration: 130.668974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:07.732423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.509153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:07.73247Z","caller":"traceutil/trace.go:171","msg":"trace[305739460] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"121.551345ms","start":"2026-05-29T13:56:07.610901Z","end":"2026-05-29T13:56:07.732452Z","steps":["trace[305739460] 'range keys from in-memory index tree' (duration: 121.434838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:07.732674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.10294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:07.732716Z","caller":"traceutil/trace.go:171","msg":"trace[317662015] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"121.26982ms","start":"2026-05-29T13:56:07.611436Z","end":"2026-05-29T13:56:07.732706Z","steps":["trace[317662015] 'count revisions from in-memory index tree' (duration: 121.035367ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:07.732844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.450258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:07.732885Z","caller":"traceutil/trace.go:171","msg":"trace[514572295] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"109.505461ms","start":"2026-05-29T13:56:07.623371Z","end":"2026-05-29T13:56:07.732876Z","steps":["trace[514572295] 'count revisions from in-memory index tree' (duration: 109.420306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:07.736306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.968577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-29T13:56:07.736421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.739719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:07.736418Z","caller":"traceutil/trace.go:171","msg":"trace[584104561] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"113.136926ms","start":"2026-05-29T13:56:07.623258Z","end":"2026-05-29T13:56:07.736395Z","steps":["trace[584104561] 'range keys from in-memory index tree' (duration: 112.819808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:07.736356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.744969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:07.737809Z","caller":"traceutil/trace.go:171","msg":"trace[1430331908] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"104.217777ms","start":"2026-05-29T13:56:07.63358Z","end":"2026-05-29T13:56:07.737797Z","steps":["trace[1430331908] 'count revisions from in-memory index tree' (duration: 102.676986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:07.744275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.985524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:07.744316Z","caller":"traceutil/trace.go:171","msg":"trace[352977181] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"101.050717ms","start":"2026-05-29T13:56:07.643254Z","end":"2026-05-29T13:56:07.744305Z","steps":["trace[352977181] 'count revisions from in-memory index tree' (duration: 100.952082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:07.744537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.376895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:07.744617Z","caller":"traceutil/trace.go:171","msg":"trace[483022891] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"101.479401ms","start":"2026-05-29T13:56:07.643121Z","end":"2026-05-29T13:56:07.744601Z","steps":["trace[483022891] 'range keys from in-memory index tree' (duration: 101.321742ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:07.739259Z","caller":"traceutil/trace.go:171","msg":"trace[73418946] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"102.789861ms","start":"2026-05-29T13:56:07.633663Z","end":"2026-05-29T13:56:07.736452Z","steps":["trace[73418946] 'range keys from in-memory index tree' (duration: 102.702757ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:09.066214Z","caller":"traceutil/trace.go:171","msg":"trace[2137864033] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"206.663789ms","start":"2026-05-29T13:56:08.859515Z","end":"2026-05-29T13:56:09.066179Z","steps":["trace[2137864033] 'process raft request' (duration: 201.174574ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:09.066264Z","caller":"traceutil/trace.go:171","msg":"trace[1006935349] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:5; }","duration":"191.657694ms","start":"2026-05-29T13:56:08.87459Z","end":"2026-05-29T13:56:09.066248Z","steps":["trace[1006935349] 'read index received' (duration: 186.151498ms)","trace[1006935349] 'applied index is now lower than readState.Index' (duration: 5.505626ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:09.066366Z","caller":"traceutil/trace.go:171","msg":"trace[581247820] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"196.846492ms","start":"2026-05-29T13:56:08.869513Z","end":"2026-05-29T13:56:09.066359Z","steps":["trace[581247820] 'process raft request' (duration: 196.710285ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:09.066463Z","caller":"traceutil/trace.go:171","msg":"trace[1901044715] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"203.12855ms","start":"2026-05-29T13:56:08.863318Z","end":"2026-05-29T13:56:09.066446Z","steps":["trace[1901044715] 'process raft request' (duration: 202.818333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:09.066598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.454156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:09.06664Z","caller":"traceutil/trace.go:171","msg":"trace[1692464807] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:9; }","duration":"203.5267ms","start":"2026-05-29T13:56:08.863102Z","end":"2026-05-29T13:56:09.066629Z","steps":["trace[1692464807] 'agreement among raft nodes before linearized reading' (duration: 203.388163ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:09.066732Z","caller":"traceutil/trace.go:171","msg":"trace[870616437] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"203.239865ms","start":"2026-05-29T13:56:08.863463Z","end":"2026-05-29T13:56:09.066703Z","steps":["trace[870616437] 'process raft request' (duration: 202.692536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:09.066778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.385075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:09.066782Z","caller":"traceutil/trace.go:171","msg":"trace[1881390460] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"203.272927ms","start":"2026-05-29T13:56:08.863497Z","end":"2026-05-29T13:56:09.06677Z","steps":["trace[1881390460] 'process raft request' (duration: 202.681425ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:09.066811Z","caller":"traceutil/trace.go:171","msg":"trace[1266826937] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:0; response_revision:9; }","duration":"209.423627ms","start":"2026-05-29T13:56:08.857365Z","end":"2026-05-29T13:56:09.066788Z","steps":["trace[1266826937] 'agreement among raft nodes before linearized reading' (duration: 209.399226ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:09.06678Z","caller":"traceutil/trace.go:171","msg":"trace[1584800719] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"203.244426ms","start":"2026-05-29T13:56:08.863509Z","end":"2026-05-29T13:56:09.066754Z","steps":["trace[1584800719] 'process raft request' (duration: 202.696537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:09.066916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.085581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:09.066961Z","caller":"traceutil/trace.go:171","msg":"trace[1066068845] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"171.154915ms","start":"2026-05-29T13:56:08.895796Z","end":"2026-05-29T13:56:09.066951Z","steps":["trace[1066068845] 'agreement among raft nodes before linearized reading' (duration: 171.073959ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:09.066958Z","caller":"traceutil/trace.go:171","msg":"trace[1362337963] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"203.410105ms","start":"2026-05-29T13:56:08.86352Z","end":"2026-05-29T13:56:09.06693Z","steps":["trace[1362337963] 'process raft request' (duration: 202.673155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:09.066753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.541506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:09.067006Z","caller":"traceutil/trace.go:171","msg":"trace[1130953444] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"204.808291ms","start":"2026-05-29T13:56:08.862186Z","end":"2026-05-29T13:56:09.066994Z","steps":["trace[1130953444] 'agreement among raft nodes before linearized reading' (duration: 204.551396ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:09.067112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.656178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:09.067147Z","caller":"traceutil/trace.go:171","msg":"trace[704591951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:9; }","duration":"271.7007ms","start":"2026-05-29T13:56:08.795438Z","end":"2026-05-29T13:56:09.067139Z","steps":["trace[704591951] 'agreement among raft nodes before linearized reading' (duration: 271.637716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:09.06727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.035291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-29T13:56:09.067284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.302324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:09.067303Z","caller":"traceutil/trace.go:171","msg":"trace[328385386] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"150.087154ms","start":"2026-05-29T13:56:08.917207Z","end":"2026-05-29T13:56:09.067295Z","steps":["trace[328385386] 'agreement among raft nodes before linearized reading' (duration: 150.043542ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:09.067328Z","caller":"traceutil/trace.go:171","msg":"trace[1428679244] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:9; }","duration":"144.364567ms","start":"2026-05-29T13:56:08.92295Z","end":"2026-05-29T13:56:09.067315Z","steps":["trace[1428679244] 'agreement among raft nodes before linearized reading' (duration: 144.297323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:09.067451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.025777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:09.067489Z","caller":"traceutil/trace.go:171","msg":"trace[1616434638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:9; }","duration":"272.07583ms","start":"2026-05-29T13:56:08.795404Z","end":"2026-05-29T13:56:09.06748Z","steps":["trace[1616434638] 'agreement among raft nodes before linearized reading' (duration: 272.022167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:09.067604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.817322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:09.067642Z","caller":"traceutil/trace.go:171","msg":"trace[45395502] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"139.915958ms","start":"2026-05-29T13:56:08.927717Z","end":"2026-05-29T13:56:09.067633Z","steps":["trace[45395502] 'agreement among raft nodes before linearized reading' (duration: 139.864165ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:09.067642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.268825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:09.06769Z","caller":"traceutil/trace.go:171","msg":"trace[254007213] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:9; }","duration":"284.347659ms","start":"2026-05-29T13:56:08.783328Z","end":"2026-05-29T13:56:09.067676Z","steps":["trace[254007213] 'agreement among raft nodes before linearized reading' (duration: 284.242844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.222346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.478324ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-29T13:56:10.222547Z","caller":"traceutil/trace.go:171","msg":"trace[540777291] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:21; }","duration":"1.074637336s","start":"2026-05-29T13:56:09.147893Z","end":"2026-05-29T13:56:10.22253Z","steps":["trace[540777291] 'read index received' (duration: 344.191491ms)","trace[540777291] 'applied index is now lower than readState.Index' (duration: 730.445035ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:10.222686Z","caller":"traceutil/trace.go:171","msg":"trace[747912984] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"1.096330322s","start":"2026-05-29T13:56:09.126329Z","end":"2026-05-29T13:56:10.222659Z","steps":["trace[747912984] 'process raft request' (duration: 1.096120161s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.222723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123886715s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:10.222763Z","caller":"traceutil/trace.go:171","msg":"trace[672899573] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:20; }","duration":"1.123957719s","start":"2026-05-29T13:56:09.098793Z","end":"2026-05-29T13:56:10.222751Z","steps":["trace[672899573] 'agreement among raft nodes before linearized reading' (duration: 1.123841903s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.222807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.098778Z","time spent":"1.124015992s","remote":"127.0.0.1:53562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"warn","ts":"2026-05-29T13:56:10.222834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.126317Z","time spent":"1.096437848s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:56:10.222691Z","caller":"traceutil/trace.go:171","msg":"trace[189113714] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"1.091819941s","start":"2026-05-29T13:56:09.130851Z","end":"2026-05-29T13:56:10.222671Z","steps":["trace[189113714] 'process raft request' (duration: 1.091642021s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.223165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099098522s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:10.223205Z","caller":"traceutil/trace.go:171","msg":"trace[109311039] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:20; }","duration":"1.099139144s","start":"2026-05-29T13:56:09.124057Z","end":"2026-05-29T13:56:10.223196Z","steps":["trace[109311039] 'agreement among raft nodes before linearized reading' (duration: 1.098545582s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.223233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.124021Z","time spent":"1.099205977s","remote":"127.0.0.1:53582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/default\" "} {"level":"info","ts":"2026-05-29T13:56:10.223229Z","caller":"traceutil/trace.go:171","msg":"trace[1659994249] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"1.098001983s","start":"2026-05-29T13:56:09.124624Z","end":"2026-05-29T13:56:10.222626Z","steps":["trace[1659994249] 'process raft request' (duration: 367.534477ms)","trace[1659994249] 'compare' (duration: 729.285893ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:56:10.223321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.124611Z","time spent":"1.098670738s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T13:56:10.223159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.130822Z","time spent":"1.092277966s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T13:56:10.835295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.17503ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-29T13:56:10.835581Z","caller":"traceutil/trace.go:171","msg":"trace[1798428951] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"1.685314863s","start":"2026-05-29T13:56:09.150211Z","end":"2026-05-29T13:56:10.835526Z","steps":["trace[1798428951] 'process raft request' (duration: 1.565662707s)","trace[1798428951] 'compare' (duration: 119.040463ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:10.835765Z","caller":"traceutil/trace.go:171","msg":"trace[2086187256] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"1.68360875s","start":"2026-05-29T13:56:09.152015Z","end":"2026-05-29T13:56:10.835624Z","steps":["trace[2086187256] 'process raft request' (duration: 1.683402629s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.835922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.150195Z","time spent":"1.685489012s","remote":"127.0.0.1:53538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T13:56:10.836053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.152Z","time spent":"1.683945878s","remote":"127.0.0.1:53932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:56:10.836095Z","caller":"traceutil/trace.go:171","msg":"trace[551921180] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"1.683775199s","start":"2026-05-29T13:56:09.152117Z","end":"2026-05-29T13:56:10.835892Z","steps":["trace[551921180] 'process raft request' (duration: 1.683363447s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.836328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.152087Z","time spent":"1.684213713s","remote":"127.0.0.1:53932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:56:10.836367Z","caller":"traceutil/trace.go:171","msg":"trace[1257542575] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"1.683086973s","start":"2026-05-29T13:56:09.153263Z","end":"2026-05-29T13:56:10.83635Z","steps":["trace[1257542575] 'process raft request' (duration: 1.682493281s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.836502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.153254Z","time spent":"1.683175667s","remote":"127.0.0.1:53856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:56:10.835809Z","caller":"traceutil/trace.go:171","msg":"trace[1024588639] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"1.683428801s","start":"2026-05-29T13:56:09.152318Z","end":"2026-05-29T13:56:10.835746Z","steps":["trace[1024588639] 'process raft request' (duration: 1.683245471s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.83688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.152296Z","time spent":"1.684499898s","remote":"127.0.0.1:53932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:56:10.836142Z","caller":"traceutil/trace.go:171","msg":"trace[162786502] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"1.683497054s","start":"2026-05-29T13:56:09.152583Z","end":"2026-05-29T13:56:10.83608Z","steps":["trace[162786502] 'process raft request' (duration: 1.683018739s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.837098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.15257Z","time spent":"1.684502859s","remote":"127.0.0.1:53802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:56:10.837224Z","caller":"traceutil/trace.go:171","msg":"trace[1860438566] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"611.820717ms","start":"2026-05-29T13:56:10.225379Z","end":"2026-05-29T13:56:10.8372Z","steps":["trace[1860438566] 'process raft request' (duration: 611.761794ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:10.837313Z","caller":"traceutil/trace.go:171","msg":"trace[1420071831] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"1.683000457s","start":"2026-05-29T13:56:09.1543Z","end":"2026-05-29T13:56:10.837301Z","steps":["trace[1420071831] 'process raft request' (duration: 1.682709021s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.837371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:10.225357Z","time spent":"611.951634ms","remote":"127.0.0.1:53582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T13:56:10.837387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.154293Z","time spent":"1.68305774s","remote":"127.0.0.1:53932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:56:10.837494Z","caller":"traceutil/trace.go:171","msg":"trace[1165060994] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"1.683618331s","start":"2026-05-29T13:56:09.153856Z","end":"2026-05-29T13:56:10.837474Z","steps":["trace[1165060994] 'process raft request' (duration: 1.682036625s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.83759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.153842Z","time spent":"1.683707736s","remote":"127.0.0.1:53932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:56:10.837498Z","caller":"traceutil/trace.go:171","msg":"trace[1284281180] linearizableReadLoop","detail":"{readStateIndex:32; appliedIndex:24; }","duration":"614.867822ms","start":"2026-05-29T13:56:10.222576Z","end":"2026-05-29T13:56:10.837443Z","steps":["trace[1284281180] 'read index received' (duration: 493.309934ms)","trace[1284281180] 'applied index is now lower than readState.Index' (duration: 121.553678ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:56:10.837704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080873198s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:10.837751Z","caller":"traceutil/trace.go:171","msg":"trace[1921355475] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:29; }","duration":"1.080943862s","start":"2026-05-29T13:56:09.756796Z","end":"2026-05-29T13:56:10.83774Z","steps":["trace[1921355475] 'agreement among raft nodes before linearized reading' (duration: 1.080692449s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.837744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.150284144s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-29T13:56:10.83778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.756785Z","time spent":"1.080989484s","remote":"127.0.0.1:53786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-05-29T13:56:10.837789Z","caller":"traceutil/trace.go:171","msg":"trace[1005567025] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:29; }","duration":"1.150378438s","start":"2026-05-29T13:56:09.687396Z","end":"2026-05-29T13:56:10.837775Z","steps":["trace[1005567025] 'agreement among raft nodes before linearized reading' (duration: 1.150247731s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.837826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.687373Z","time spent":"1.150444942s","remote":"127.0.0.1:53598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":26,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-05-29T13:56:10.837844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.563726581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:10.837909Z","caller":"traceutil/trace.go:171","msg":"trace[1414426745] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:29; }","duration":"1.563847937s","start":"2026-05-29T13:56:09.274035Z","end":"2026-05-29T13:56:10.837883Z","steps":["trace[1414426745] 'agreement among raft nodes before linearized reading' (duration: 1.563749942s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.837931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.687460068s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-05-29T13:56:10.837964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080969873s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-29T13:56:10.837963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.274018Z","time spent":"1.563935462s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-05-29T13:56:10.837997Z","caller":"traceutil/trace.go:171","msg":"trace[344550249] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:29; }","duration":"1.081044488s","start":"2026-05-29T13:56:09.756944Z","end":"2026-05-29T13:56:10.837988Z","steps":["trace[344550249] 'agreement among raft nodes before linearized reading' (duration: 1.080999665s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.838025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.756937Z","time spent":"1.081082989s","remote":"127.0.0.1:53770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-05-29T13:56:10.83802Z","caller":"traceutil/trace.go:171","msg":"trace[593575345] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:29; }","duration":"1.687550563s","start":"2026-05-29T13:56:09.150431Z","end":"2026-05-29T13:56:10.837981Z","steps":["trace[593575345] 'agreement among raft nodes before linearized reading' (duration: 1.687417166s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.838112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.65131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-29T13:56:10.838114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.039022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-29T13:56:10.838148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.150421Z","time spent":"1.687644679s","remote":"127.0.0.1:53582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-29T13:56:10.838176Z","caller":"traceutil/trace.go:171","msg":"trace[1360764573] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:29; }","duration":"558.706844ms","start":"2026-05-29T13:56:10.279451Z","end":"2026-05-29T13:56:10.838158Z","steps":["trace[1360764573] 'agreement among raft nodes before linearized reading' (duration: 558.63353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.838213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:10.279387Z","time spent":"558.819389ms","remote":"127.0.0.1:53582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-05-29T13:56:10.83793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040211921s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:10.838198Z","caller":"traceutil/trace.go:171","msg":"trace[1722601090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:29; }","duration":"610.211422ms","start":"2026-05-29T13:56:10.227964Z","end":"2026-05-29T13:56:10.838175Z","steps":["trace[1722601090] 'agreement among raft nodes before linearized reading' (duration: 609.99275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.838284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.080944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-05-29T13:56:10.838283Z","caller":"traceutil/trace.go:171","msg":"trace[356599400] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29; }","duration":"1.040592542s","start":"2026-05-29T13:56:09.797676Z","end":"2026-05-29T13:56:10.838268Z","steps":["trace[356599400] 'agreement among raft nodes before linearized reading' (duration: 1.040232112s)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:10.838319Z","caller":"traceutil/trace.go:171","msg":"trace[1723549869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:29; }","duration":"610.156728ms","start":"2026-05-29T13:56:10.228153Z","end":"2026-05-29T13:56:10.83831Z","steps":["trace[1723549869] 'agreement among raft nodes before linearized reading' (duration: 610.092114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.838321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:10.22793Z","time spent":"610.37539ms","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T13:56:10.838342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:09.797657Z","time spent":"1.040662635s","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T13:56:10.83838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:10.228138Z","time spent":"610.230762ms","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-29T13:56:10.998013Z","caller":"traceutil/trace.go:171","msg":"trace[2008377085] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"154.032711ms","start":"2026-05-29T13:56:10.843958Z","end":"2026-05-29T13:56:10.99799Z","steps":["trace[2008377085] 'process raft request' (duration: 132.752562ms)","trace[2008377085] 'compare' (duration: 21.153542ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:10.998534Z","caller":"traceutil/trace.go:171","msg":"trace[2073956797] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"154.008399ms","start":"2026-05-29T13:56:10.844512Z","end":"2026-05-29T13:56:10.998521Z","steps":["trace[2073956797] 'process raft request' (duration: 153.600607ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:10.998586Z","caller":"traceutil/trace.go:171","msg":"trace[1435312132] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"153.396817ms","start":"2026-05-29T13:56:10.845171Z","end":"2026-05-29T13:56:10.998567Z","steps":["trace[1435312132] 'process raft request' (duration: 153.231438ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:10.998684Z","caller":"traceutil/trace.go:171","msg":"trace[38004548] linearizableReadLoop","detail":"{readStateIndex:36; appliedIndex:33; }","duration":"153.545704ms","start":"2026-05-29T13:56:10.84511Z","end":"2026-05-29T13:56:10.998656Z","steps":["trace[38004548] 'read index received' (duration: 131.546027ms)","trace[38004548] 'applied index is now lower than readState.Index' (duration: 21.998267ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:10.99889Z","caller":"traceutil/trace.go:171","msg":"trace[1587241707] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"153.751795ms","start":"2026-05-29T13:56:10.845123Z","end":"2026-05-29T13:56:10.998875Z","steps":["trace[1587241707] 'process raft request' (duration: 153.167124ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:10.998849Z","caller":"traceutil/trace.go:171","msg":"trace[1685076494] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"154.099134ms","start":"2026-05-29T13:56:10.844734Z","end":"2026-05-29T13:56:10.998833Z","steps":["trace[1685076494] 'process raft request' (duration: 153.511752ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:10.99905Z","caller":"traceutil/trace.go:171","msg":"trace[441138445] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"153.897993ms","start":"2026-05-29T13:56:10.845142Z","end":"2026-05-29T13:56:10.99904Z","steps":["trace[441138445] 'process raft request' (duration: 153.208596ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:10.999116Z","caller":"traceutil/trace.go:171","msg":"trace[1374725712] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"100.806869ms","start":"2026-05-29T13:56:10.898294Z","end":"2026-05-29T13:56:10.999101Z","steps":["trace[1374725712] 'process raft request' (duration: 100.326463ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:10.999169Z","caller":"traceutil/trace.go:171","msg":"trace[823463861] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"150.87424ms","start":"2026-05-29T13:56:10.848166Z","end":"2026-05-29T13:56:10.99904Z","steps":["trace[823463861] 'process raft request' (duration: 150.421726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.999358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.232851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:10.999436Z","caller":"traceutil/trace.go:171","msg":"trace[1914267636] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:41; }","duration":"154.324876ms","start":"2026-05-29T13:56:10.845093Z","end":"2026-05-29T13:56:10.999418Z","steps":["trace[1914267636] 'agreement among raft nodes before linearized reading' (duration: 154.143766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.999425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.166938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:10.999503Z","caller":"traceutil/trace.go:171","msg":"trace[1915916822] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:41; }","duration":"154.267682ms","start":"2026-05-29T13:56:10.845211Z","end":"2026-05-29T13:56:10.999479Z","steps":["trace[1915916822] 'agreement among raft nodes before linearized reading' (duration: 154.085113ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:10.999681Z","caller":"traceutil/trace.go:171","msg":"trace[1024992493] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"153.478909ms","start":"2026-05-29T13:56:10.846187Z","end":"2026-05-29T13:56:10.999666Z","steps":["trace[1024992493] 'process raft request' (duration: 152.318197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:10.999883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.197165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:10.999922Z","caller":"traceutil/trace.go:171","msg":"trace[1293274671] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:41; }","duration":"105.26314ms","start":"2026-05-29T13:56:10.894649Z","end":"2026-05-29T13:56:10.999912Z","steps":["trace[1293274671] 'agreement among raft nodes before linearized reading' (duration: 105.211116ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:10.999923Z","caller":"traceutil/trace.go:171","msg":"trace[2038400527] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"153.223267ms","start":"2026-05-29T13:56:10.846688Z","end":"2026-05-29T13:56:10.999911Z","steps":["trace[2038400527] 'process raft request' (duration: 151.868423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:11.000248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.596212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-29T13:56:11.000294Z","caller":"traceutil/trace.go:171","msg":"trace[2123852043] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"155.080207ms","start":"2026-05-29T13:56:10.845201Z","end":"2026-05-29T13:56:11.000281Z","steps":["trace[2123852043] 'process raft request' (duration: 153.235178ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:11.000303Z","caller":"traceutil/trace.go:171","msg":"trace[1193092515] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:41; }","duration":"154.664945ms","start":"2026-05-29T13:56:10.845627Z","end":"2026-05-29T13:56:11.000292Z","steps":["trace[1193092515] 'agreement among raft nodes before linearized reading' (duration: 154.479875ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:11.00034Z","caller":"traceutil/trace.go:171","msg":"trace[1713283835] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"154.778311ms","start":"2026-05-29T13:56:10.845539Z","end":"2026-05-29T13:56:11.000317Z","steps":["trace[1713283835] 'process raft request' (duration: 152.938872ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:12.448387Z","caller":"traceutil/trace.go:171","msg":"trace[903425553] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"341.40356ms","start":"2026-05-29T13:56:12.106947Z","end":"2026-05-29T13:56:12.44835Z","steps":["trace[903425553] 'process raft request' (duration: 332.670326ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:12.448596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:12.106928Z","time spent":"341.572529ms","remote":"127.0.0.1:53772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":730,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:56:17.817779Z","caller":"traceutil/trace.go:171","msg":"trace[1342446677] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"130.397837ms","start":"2026-05-29T13:56:17.687344Z","end":"2026-05-29T13:56:17.817742Z","steps":["trace[1342446677] 'process raft request' (duration: 91.379228ms)","trace[1342446677] 'compare' (duration: 38.811128ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:18.432736Z","caller":"traceutil/trace.go:171","msg":"trace[1434706644] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"161.656499ms","start":"2026-05-29T13:56:18.27105Z","end":"2026-05-29T13:56:18.432706Z","steps":["trace[1434706644] 'process raft request' (duration: 101.423271ms)","trace[1434706644] 'compare' (duration: 59.878339ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:18.433178Z","caller":"traceutil/trace.go:171","msg":"trace[233283183] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:357; }","duration":"139.565735ms","start":"2026-05-29T13:56:18.293603Z","end":"2026-05-29T13:56:18.433168Z","steps":["trace[233283183] 'read index received' (duration: 78.981298ms)","trace[233283183] 'applied index is now lower than readState.Index' (duration: 60.583697ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:18.433257Z","caller":"traceutil/trace.go:171","msg":"trace[67469267] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"139.807179ms","start":"2026-05-29T13:56:18.293424Z","end":"2026-05-29T13:56:18.433231Z","steps":["trace[67469267] 'process raft request' (duration: 139.245358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:18.433308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.688203ms","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-29T13:56:18.433527Z","caller":"traceutil/trace.go:171","msg":"trace[1453218714] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:345; }","duration":"139.940807ms","start":"2026-05-29T13:56:18.293563Z","end":"2026-05-29T13:56:18.433504Z","steps":["trace[1453218714] 'agreement among raft nodes before linearized reading' (duration: 139.684363ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:18.741176Z","caller":"traceutil/trace.go:171","msg":"trace[1066348782] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"103.092952ms","start":"2026-05-29T13:56:18.638054Z","end":"2026-05-29T13:56:18.741147Z","steps":["trace[1066348782] 'process raft request' (duration: 75.873017ms)","trace[1066348782] 'compare' (duration: 26.982522ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:18.779884Z","caller":"traceutil/trace.go:171","msg":"trace[157173860] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:369; }","duration":"130.634247ms","start":"2026-05-29T13:56:18.649221Z","end":"2026-05-29T13:56:18.779855Z","steps":["trace[157173860] 'read index received' (duration: 64.686704ms)","trace[157173860] 'applied index is now lower than readState.Index' (duration: 65.947002ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:56:18.780037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.794415ms","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-29T13:56:18.780085Z","caller":"traceutil/trace.go:171","msg":"trace[1481235680] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:358; }","duration":"130.886061ms","start":"2026-05-29T13:56:18.649189Z","end":"2026-05-29T13:56:18.780075Z","steps":["trace[1481235680] 'agreement among raft nodes before linearized reading' (duration: 130.795896ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:18.780046Z","caller":"traceutil/trace.go:171","msg":"trace[1890950593] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"123.852095ms","start":"2026-05-29T13:56:18.656157Z","end":"2026-05-29T13:56:18.780009Z","steps":["trace[1890950593] 'process raft request' (duration: 123.639273ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:18.780138Z","caller":"traceutil/trace.go:171","msg":"trace[930135777] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"131.044668ms","start":"2026-05-29T13:56:18.648878Z","end":"2026-05-29T13:56:18.779923Z","steps":["trace[930135777] 'process raft request' (duration: 130.822376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:18.960206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.71002ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-29T13:56:18.960552Z","caller":"traceutil/trace.go:171","msg":"trace[990223789] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"159.280059ms","start":"2026-05-29T13:56:18.801203Z","end":"2026-05-29T13:56:18.960483Z","steps":["trace[990223789] 'process raft request' (duration: 46.177237ms)","trace[990223789] 'compare' (duration: 112.418025ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:18.960635Z","caller":"traceutil/trace.go:171","msg":"trace[231715951] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"159.262958ms","start":"2026-05-29T13:56:18.801344Z","end":"2026-05-29T13:56:18.960607Z","steps":["trace[231715951] 'process raft request' (duration: 159.007694ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:18.960683Z","caller":"traceutil/trace.go:171","msg":"trace[1769287454] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:380; }","duration":"156.868316ms","start":"2026-05-29T13:56:18.803784Z","end":"2026-05-29T13:56:18.960652Z","steps":["trace[1769287454] 'read index received' (duration: 32.824923ms)","trace[1769287454] 'applied index is now lower than readState.Index' (duration: 124.041823ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:18.960796Z","caller":"traceutil/trace.go:171","msg":"trace[1662805057] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"158.58351ms","start":"2026-05-29T13:56:18.802157Z","end":"2026-05-29T13:56:18.96074Z","steps":["trace[1662805057] 'process raft request' (duration: 158.273943ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:18.960846Z","caller":"traceutil/trace.go:171","msg":"trace[928796257] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"157.173942ms","start":"2026-05-29T13:56:18.803648Z","end":"2026-05-29T13:56:18.960822Z","steps":["trace[928796257] 'process raft request' (duration: 156.93808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:18.961002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.204365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:1 size:2108"} {"level":"info","ts":"2026-05-29T13:56:18.961041Z","caller":"traceutil/trace.go:171","msg":"trace[423772089] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:1; response_revision:370; }","duration":"157.30634ms","start":"2026-05-29T13:56:18.803723Z","end":"2026-05-29T13:56:18.961029Z","steps":["trace[423772089] 'agreement among raft nodes before linearized reading' (duration: 157.201274ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:18.961971Z","caller":"traceutil/trace.go:171","msg":"trace[616026882] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"121.760778ms","start":"2026-05-29T13:56:18.840195Z","end":"2026-05-29T13:56:18.961956Z","steps":["trace[616026882] 'process raft request' (duration: 121.575418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:18.961964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.655822ms","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-29T13:56:18.962016Z","caller":"traceutil/trace.go:171","msg":"trace[1057620383] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:371; }","duration":"123.720866ms","start":"2026-05-29T13:56:18.838281Z","end":"2026-05-29T13:56:18.962002Z","steps":["trace[1057620383] 'agreement among raft nodes before linearized reading' (duration: 123.583128ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:19.102616Z","caller":"traceutil/trace.go:171","msg":"trace[658550905] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"107.078621ms","start":"2026-05-29T13:56:18.995514Z","end":"2026-05-29T13:56:19.102593Z","steps":["trace[658550905] 'process raft request' (duration: 100.807486ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:41.728155Z","caller":"traceutil/trace.go:171","msg":"trace[1445338297] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"146.602267ms","start":"2026-05-29T13:56:41.581527Z","end":"2026-05-29T13:56:41.728129Z","steps":["trace[1445338297] 'process raft request' (duration: 146.458488ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:46.777898Z","caller":"traceutil/trace.go:171","msg":"trace[1579363490] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"131.381954ms","start":"2026-05-29T13:56:46.646483Z","end":"2026-05-29T13:56:46.777865Z","steps":["trace[1579363490] 'process raft request' (duration: 131.284855ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:46.778391Z","caller":"traceutil/trace.go:171","msg":"trace[446943504] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"131.87137ms","start":"2026-05-29T13:56:46.64643Z","end":"2026-05-29T13:56:46.778301Z","steps":["trace[446943504] 'process raft request' (duration: 127.950952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:49.154447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.055443ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-29T13:56:49.154593Z","caller":"traceutil/trace.go:171","msg":"trace[654522597] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"672.997828ms","start":"2026-05-29T13:56:48.481567Z","end":"2026-05-29T13:56:49.154564Z","steps":["trace[654522597] 'read index received' (duration: 22.699µs)","trace[654522597] 'applied index is now lower than readState.Index' (duration: 672.973129ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:56:49.155045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.716007ms","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-29T13:56:49.155128Z","caller":"traceutil/trace.go:171","msg":"trace[700874981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:529; }","duration":"490.851777ms","start":"2026-05-29T13:56:48.664249Z","end":"2026-05-29T13:56:49.1551Z","steps":["trace[700874981] 'agreement among raft nodes before linearized reading' (duration: 490.648948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:49.155277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:48.664227Z","time spent":"490.955206ms","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-29T13:56:49.155469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.537095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:56:49.155635Z","caller":"traceutil/trace.go:171","msg":"trace[1928821658] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:529; }","duration":"674.075473ms","start":"2026-05-29T13:56:48.481522Z","end":"2026-05-29T13:56:49.155597Z","steps":["trace[1928821658] 'agreement among raft nodes before linearized reading' (duration: 673.089268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:49.155729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:48.481502Z","time spent":"674.217602ms","remote":"127.0.0.1:53564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-05-29T13:56:49.842116Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102682206821782,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T13:56:50.342916Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102682206821782,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-29T13:56:50.45621Z","caller":"traceutil/trace.go:171","msg":"trace[212058595] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:552; }","duration":"1.115862762s","start":"2026-05-29T13:56:49.340313Z","end":"2026-05-29T13:56:50.456176Z","steps":["trace[212058595] 'read index received' (duration: 1.115477814s)","trace[212058595] 'applied index is now lower than readState.Index' (duration: 383.328µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:50.456444Z","caller":"traceutil/trace.go:171","msg":"trace[1368148345] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.297182019s","start":"2026-05-29T13:56:49.159247Z","end":"2026-05-29T13:56:50.456429Z","steps":["trace[1368148345] 'process raft request' (duration: 1.296697331s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:50.456616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:49.159178Z","time spent":"1.297313119s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T13:56:50.456776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.163479ms","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-29T13:56:50.456797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.99958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:56:50.456829Z","caller":"traceutil/trace.go:171","msg":"trace[2063290792] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:530; }","duration":"596.277398ms","start":"2026-05-29T13:56:49.860538Z","end":"2026-05-29T13:56:50.456815Z","steps":["trace[2063290792] 'agreement among raft nodes before linearized reading' (duration: 596.160999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:50.456791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.354741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T13:56:50.456882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:49.860508Z","time spent":"596.366758ms","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-29T13:56:50.456889Z","caller":"traceutil/trace.go:171","msg":"trace[76764090] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:530; }","duration":"961.138199ms","start":"2026-05-29T13:56:49.495725Z","end":"2026-05-29T13:56:50.456864Z","steps":["trace[76764090] 'agreement among raft nodes before linearized reading' (duration: 960.96305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:50.456945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:49.495706Z","time spent":"961.228769ms","remote":"127.0.0.1:53564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-05-29T13:56:50.456915Z","caller":"traceutil/trace.go:171","msg":"trace[788384321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:530; }","duration":"419.5962ms","start":"2026-05-29T13:56:50.037298Z","end":"2026-05-29T13:56:50.456894Z","steps":["trace[788384321] 'agreement among raft nodes before linearized reading' (duration: 419.385041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:50.456994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116654709s","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-29T13:56:50.457091Z","caller":"traceutil/trace.go:171","msg":"trace[1869921866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:530; }","duration":"1.116812188s","start":"2026-05-29T13:56:49.340259Z","end":"2026-05-29T13:56:50.457072Z","steps":["trace[1869921866] 'agreement among raft nodes before linearized reading' (duration: 1.11650143s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:50.457137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:49.340236Z","time spent":"1.116892178s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T13:56:50.456998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:50.037262Z","time spent":"419.724049ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T13:56:50.457272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090020779s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-29T13:56:50.457341Z","caller":"traceutil/trace.go:171","msg":"trace[2127628836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:530; }","duration":"1.090266247s","start":"2026-05-29T13:56:49.367055Z","end":"2026-05-29T13:56:50.457321Z","steps":["trace[2127628836] 'agreement among raft nodes before linearized reading' (duration: 1.089488591s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:50.4574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:49.367012Z","time spent":"1.090374827s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-29T13:56:50.830378Z","caller":"traceutil/trace.go:171","msg":"trace[1245336640] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"176.620353ms","start":"2026-05-29T13:56:50.653731Z","end":"2026-05-29T13:56:50.830351Z","steps":["trace[1245336640] 'process raft request' (duration: 176.472084ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.926666Z","caller":"traceutil/trace.go:171","msg":"trace[327469753] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"198.22153ms","start":"2026-05-29T13:56:50.728408Z","end":"2026-05-29T13:56:50.92663Z","steps":["trace[327469753] 'process raft request' (duration: 197.619243ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.926715Z","caller":"traceutil/trace.go:171","msg":"trace[1278694020] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"158.008495ms","start":"2026-05-29T13:56:50.768666Z","end":"2026-05-29T13:56:50.926675Z","steps":["trace[1278694020] 'process raft request' (duration: 157.572537ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.926961Z","caller":"traceutil/trace.go:171","msg":"trace[26124073] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"190.883241ms","start":"2026-05-29T13:56:50.736066Z","end":"2026-05-29T13:56:50.92695Z","steps":["trace[26124073] 'process raft request' (duration: 190.007396ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.927072Z","caller":"traceutil/trace.go:171","msg":"trace[1964901654] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"175.980547ms","start":"2026-05-29T13:56:50.751079Z","end":"2026-05-29T13:56:50.92706Z","steps":["trace[1964901654] 'process raft request' (duration: 175.077381ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.927088Z","caller":"traceutil/trace.go:171","msg":"trace[1414002906] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"249.504297ms","start":"2026-05-29T13:56:50.677502Z","end":"2026-05-29T13:56:50.927006Z","steps":["trace[1414002906] 'process raft request' (duration: 248.168583ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.927209Z","caller":"traceutil/trace.go:171","msg":"trace[596275726] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"141.922524ms","start":"2026-05-29T13:56:50.785276Z","end":"2026-05-29T13:56:50.927199Z","steps":["trace[596275726] 'process raft request' (duration: 141.124148ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.927267Z","caller":"traceutil/trace.go:171","msg":"trace[661940720] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"198.856317ms","start":"2026-05-29T13:56:50.728333Z","end":"2026-05-29T13:56:50.927189Z","steps":["trace[661940720] 'process raft request' (duration: 197.645303ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.927249Z","caller":"traceutil/trace.go:171","msg":"trace[609332927] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"130.700703ms","start":"2026-05-29T13:56:50.796529Z","end":"2026-05-29T13:56:50.92723Z","steps":["trace[609332927] 'process raft request' (duration: 129.936107ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.927159Z","caller":"traceutil/trace.go:171","msg":"trace[1007868288] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"249.597746ms","start":"2026-05-29T13:56:50.677552Z","end":"2026-05-29T13:56:50.927149Z","steps":["trace[1007868288] 'process raft request' (duration: 248.365012ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.927554Z","caller":"traceutil/trace.go:171","msg":"trace[548635595] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"153.137485ms","start":"2026-05-29T13:56:50.773818Z","end":"2026-05-29T13:56:50.926955Z","steps":["trace[548635595] 'process raft request' (duration: 152.521878ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.97186Z","caller":"traceutil/trace.go:171","msg":"trace[810303633] transaction","detail":"{read_only:false; number_of_response:1; response_revision:546; }","duration":"132.224396ms","start":"2026-05-29T13:56:50.839581Z","end":"2026-05-29T13:56:50.971805Z","steps":["trace[810303633] 'process raft request' (duration: 132.173186ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.972166Z","caller":"traceutil/trace.go:171","msg":"trace[1661953629] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"134.054818ms","start":"2026-05-29T13:56:50.838088Z","end":"2026-05-29T13:56:50.972143Z","steps":["trace[1661953629] 'process raft request' (duration: 133.57425ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:50.972166Z","caller":"traceutil/trace.go:171","msg":"trace[1759880568] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"135.619471ms","start":"2026-05-29T13:56:50.836493Z","end":"2026-05-29T13:56:50.972112Z","steps":["trace[1759880568] 'process raft request' (duration: 134.978004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:51.157807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.54086ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T13:56:51.157922Z","caller":"traceutil/trace.go:171","msg":"trace[438513140] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"174.450204ms","start":"2026-05-29T13:56:50.983453Z","end":"2026-05-29T13:56:51.157903Z","steps":["trace[438513140] 'process raft request' (duration: 62.725645ms)","trace[438513140] 'compare' (duration: 111.362761ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:51.202361Z","caller":"traceutil/trace.go:171","msg":"trace[1580505020] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"197.943159ms","start":"2026-05-29T13:56:51.004375Z","end":"2026-05-29T13:56:51.202318Z","steps":["trace[1580505020] 'process raft request' (duration: 197.636891ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:51.202734Z","caller":"traceutil/trace.go:171","msg":"trace[43556370] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"175.805666ms","start":"2026-05-29T13:56:51.026884Z","end":"2026-05-29T13:56:51.202689Z","steps":["trace[43556370] 'process raft request' (duration: 175.690626ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:51.202782Z","caller":"traceutil/trace.go:171","msg":"trace[854343300] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"176.673984ms","start":"2026-05-29T13:56:51.026077Z","end":"2026-05-29T13:56:51.202751Z","steps":["trace[854343300] 'process raft request' (duration: 176.174886ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:51.447966Z","caller":"traceutil/trace.go:171","msg":"trace[110407986] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"379.724566ms","start":"2026-05-29T13:56:51.068185Z","end":"2026-05-29T13:56:51.44791Z","steps":["trace[110407986] 'process raft request' (duration: 300.748522ms)","trace[110407986] 'compare' (duration: 78.650406ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:56:51.448131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:51.068156Z","time spent":"379.895046ms","remote":"127.0.0.1:53514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:56:51.448193Z","caller":"traceutil/trace.go:171","msg":"trace[1492276334] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"279.804304ms","start":"2026-05-29T13:56:51.16834Z","end":"2026-05-29T13:56:51.448144Z","steps":["trace[1492276334] 'process raft request' (duration: 279.744445ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:51.448387Z","caller":"traceutil/trace.go:171","msg":"trace[464836974] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"359.057558ms","start":"2026-05-29T13:56:51.089304Z","end":"2026-05-29T13:56:51.448362Z","steps":["trace[464836974] 'process raft request' (duration: 358.51494ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:51.448433Z","caller":"traceutil/trace.go:171","msg":"trace[22691481] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"281.604367ms","start":"2026-05-29T13:56:51.166816Z","end":"2026-05-29T13:56:51.44842Z","steps":["trace[22691481] 'process raft request' (duration: 281.207559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:51.448507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:51.089288Z","time spent":"359.152657ms","remote":"127.0.0.1:53514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T13:56:51.616614Z","caller":"traceutil/trace.go:171","msg":"trace[2111875256] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"155.931355ms","start":"2026-05-29T13:56:51.460657Z","end":"2026-05-29T13:56:51.616589Z","steps":["trace[2111875256] 'process raft request' (duration: 133.438674ms)","trace[2111875256] 'compare' (duration: 22.282792ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:51.616918Z","caller":"traceutil/trace.go:171","msg":"trace[149325668] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"143.117021ms","start":"2026-05-29T13:56:51.473789Z","end":"2026-05-29T13:56:51.616906Z","steps":["trace[149325668] 'process raft request' (duration: 142.725382ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:51.853944Z","caller":"traceutil/trace.go:171","msg":"trace[1881008803] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"149.403619ms","start":"2026-05-29T13:56:51.70452Z","end":"2026-05-29T13:56:51.853923Z","steps":["trace[1881008803] 'process raft request' (duration: 84.403306ms)","trace[1881008803] 'compare' (duration: 64.909233ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:51.858451Z","caller":"traceutil/trace.go:171","msg":"trace[1161363559] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"138.118288ms","start":"2026-05-29T13:56:51.720303Z","end":"2026-05-29T13:56:51.858421Z","steps":["trace[1161363559] 'process raft request' (duration: 137.870289ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:58.167384Z","caller":"traceutil/trace.go:171","msg":"trace[2101317351] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"127.768391ms","start":"2026-05-29T13:56:58.039586Z","end":"2026-05-29T13:56:58.167354Z","steps":["trace[2101317351] 'read index received' (duration: 127.52838ms)","trace[2101317351] 'applied index is now lower than readState.Index' (duration: 238.911µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:56:58.167581Z","caller":"traceutil/trace.go:171","msg":"trace[714198895] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"536.608521ms","start":"2026-05-29T13:56:57.630924Z","end":"2026-05-29T13:56:58.167533Z","steps":["trace[714198895] 'process raft request' (duration: 535.738099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:58.167714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.104901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:56:58.167815Z","caller":"traceutil/trace.go:171","msg":"trace[395768789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"128.265462ms","start":"2026-05-29T13:56:58.039523Z","end":"2026-05-29T13:56:58.167788Z","steps":["trace[395768789] 'agreement among raft nodes before linearized reading' (duration: 128.014461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:56:58.16788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:57.630873Z","time spent":"536.822601ms","remote":"127.0.0.1:53564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T13:56:58.49025Z","caller":"traceutil/trace.go:171","msg":"trace[1251186590] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"298.591012ms","start":"2026-05-29T13:56:58.191623Z","end":"2026-05-29T13:56:58.490214Z","steps":["trace[1251186590] 'process raft request' (duration: 298.388472ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:56:58.557152Z","caller":"traceutil/trace.go:171","msg":"trace[132732964] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"320.9407ms","start":"2026-05-29T13:56:58.236159Z","end":"2026-05-29T13:56:58.557099Z","steps":["trace[132732964] 'process raft request' (duration: 275.602374ms)","trace[132732964] 'compare' (duration: 44.928665ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:56:58.557381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:58.236139Z","time spent":"321.12711ms","remote":"127.0.0.1:53772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T13:56:59.06987Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102682206821967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T13:56:59.570213Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102682206821967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T13:57:00.0713Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102682206821967,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T13:57:00.528332Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.965207451s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-29T13:57:00.702672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.756487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T13:57:00.704408Z","caller":"traceutil/trace.go:171","msg":"trace[1779720367] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"2.141346306s","start":"2026-05-29T13:56:58.56295Z","end":"2026-05-29T13:57:00.704297Z","steps":["trace[1779720367] 'process raft request' (duration: 1.965838754s)","trace[1779720367] 'compare' (duration: 172.489691ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:57:00.704621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:58.562898Z","time spent":"2.141607557s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T13:57:00.715377Z","caller":"traceutil/trace.go:171","msg":"trace[1806812220] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:666; }","duration":"2.145597482s","start":"2026-05-29T13:56:58.569719Z","end":"2026-05-29T13:57:00.715317Z","steps":["trace[1806812220] 'read index received' (duration: 1.958947569s)","trace[1806812220] 'applied index is now lower than readState.Index' (duration: 186.648133ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:57:00.715604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.558344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T13:57:00.715601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.145863973s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:00.715646Z","caller":"traceutil/trace.go:171","msg":"trace[1385743589] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:642; }","duration":"2.146014493s","start":"2026-05-29T13:56:58.569619Z","end":"2026-05-29T13:57:00.715634Z","steps":["trace[1385743589] 'agreement among raft nodes before linearized reading' (duration: 2.145853012s)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:57:00.715668Z","caller":"traceutil/trace.go:171","msg":"trace[1492735298] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"677.670744ms","start":"2026-05-29T13:57:00.037962Z","end":"2026-05-29T13:57:00.715632Z","steps":["trace[1492735298] 'agreement among raft nodes before linearized reading' (duration: 677.587374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:00.715677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:58.569608Z","time spent":"2.146060393s","remote":"127.0.0.1:53908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-05-29T13:57:00.715701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:57:00.037927Z","time spent":"677.766005ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T13:57:00.715939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.109585177s","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-29T13:57:00.716007Z","caller":"traceutil/trace.go:171","msg":"trace[463894577] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:642; }","duration":"2.109703297s","start":"2026-05-29T13:56:58.606291Z","end":"2026-05-29T13:57:00.715994Z","steps":["trace[463894577] 'agreement among raft nodes before linearized reading' (duration: 2.109219306s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:00.716084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:58.606261Z","time spent":"2.109813427s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-29T13:57:00.716184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.108357484s","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-29T13:57:00.716358Z","caller":"traceutil/trace.go:171","msg":"trace[1488657273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"2.108558356s","start":"2026-05-29T13:56:58.607731Z","end":"2026-05-29T13:57:00.71629Z","steps":["trace[1488657273] 'agreement among raft nodes before linearized reading' (duration: 2.107819293s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:00.716513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:58.607678Z","time spent":"2.108816997s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-29T13:57:00.716325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.108165535s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-29T13:57:00.716777Z","caller":"traceutil/trace.go:171","msg":"trace[252444924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"2.108651627s","start":"2026-05-29T13:56:58.608089Z","end":"2026-05-29T13:57:00.71674Z","steps":["trace[252444924] 'agreement among raft nodes before linearized reading' (duration: 2.107440952s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:00.716852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:56:58.60808Z","time spent":"2.108755737s","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-29T13:57:02.811053Z","caller":"traceutil/trace.go:171","msg":"trace[1131440320] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"285.483672ms","start":"2026-05-29T13:57:02.525515Z","end":"2026-05-29T13:57:02.810999Z","steps":["trace[1131440320] 'process raft request' (duration: 283.293872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:02.812639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.218017ms","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-29T13:57:02.812754Z","caller":"traceutil/trace.go:171","msg":"trace[907054101] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:666; }","duration":"100.396607ms","start":"2026-05-29T13:57:02.712336Z","end":"2026-05-29T13:57:02.812733Z","steps":["trace[907054101] 'agreement among raft nodes before linearized reading' (duration: 98.694288ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:57:06.471951Z","caller":"traceutil/trace.go:171","msg":"trace[989455049] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"119.022829ms","start":"2026-05-29T13:57:06.352897Z","end":"2026-05-29T13:57:06.47192Z","steps":["trace[989455049] 'process raft request' (duration: 118.736896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.341366Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.111594591s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T13:57:18.341701Z","caller":"traceutil/trace.go:171","msg":"trace[1901566285] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:844; }","duration":"303.730818ms","start":"2026-05-29T13:57:18.037951Z","end":"2026-05-29T13:57:18.341682Z","steps":["trace[1901566285] 'read index received' (duration: 303.586446ms)","trace[1901566285] 'applied index is now lower than readState.Index' (duration: 143.002µs)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:57:18.341908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.62341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T13:57:18.341906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.944111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T13:57:18.341994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.6632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.342025Z","caller":"traceutil/trace.go:171","msg":"trace[20977610] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:814; }","duration":"102.715551ms","start":"2026-05-29T13:57:18.239302Z","end":"2026-05-29T13:57:18.342018Z","steps":["trace[20977610] 'agreement among raft nodes before linearized reading' (duration: 102.66782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.342038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.533608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.342159Z","caller":"traceutil/trace.go:171","msg":"trace[75249605] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:814; }","duration":"102.744862ms","start":"2026-05-29T13:57:18.239389Z","end":"2026-05-29T13:57:18.342134Z","steps":["trace[75249605] 'agreement among raft nodes before linearized reading' (duration: 102.492878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.342265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.804511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.3423Z","caller":"traceutil/trace.go:171","msg":"trace[421682734] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:814; }","duration":"174.850722ms","start":"2026-05-29T13:57:18.167439Z","end":"2026-05-29T13:57:18.34229Z","steps":["trace[421682734] 'agreement among raft nodes before linearized reading' (duration: 174.799891ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.342448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.307811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.342527Z","caller":"traceutil/trace.go:171","msg":"trace[573313310] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:814; }","duration":"195.383812ms","start":"2026-05-29T13:57:18.147094Z","end":"2026-05-29T13:57:18.342477Z","steps":["trace[573313310] 'agreement among raft nodes before linearized reading' (duration: 195.332321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.342686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.626376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.342722Z","caller":"traceutil/trace.go:171","msg":"trace[134282983] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:814; }","duration":"195.688216ms","start":"2026-05-29T13:57:18.147025Z","end":"2026-05-29T13:57:18.342713Z","steps":["trace[134282983] 'agreement among raft nodes before linearized reading' (duration: 195.630105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.342845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.006916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.342879Z","caller":"traceutil/trace.go:171","msg":"trace[1267370047] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:814; }","duration":"236.057408ms","start":"2026-05-29T13:57:18.106814Z","end":"2026-05-29T13:57:18.342872Z","steps":["trace[1267370047] 'agreement among raft nodes before linearized reading' (duration: 236.006857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.343035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.688797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.343091Z","caller":"traceutil/trace.go:171","msg":"trace[1553719580] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:814; }","duration":"236.788998ms","start":"2026-05-29T13:57:18.106285Z","end":"2026-05-29T13:57:18.343074Z","steps":["trace[1553719580] 'agreement among raft nodes before linearized reading' (duration: 236.714986ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:57:18.34199Z","caller":"traceutil/trace.go:171","msg":"trace[95876854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"304.097303ms","start":"2026-05-29T13:57:18.037875Z","end":"2026-05-29T13:57:18.341972Z","steps":["trace[95876854] 'agreement among raft nodes before linearized reading' (duration: 303.942601ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.343203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.915633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T13:57:18.343227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:57:18.03783Z","time spent":"305.387704ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-29T13:57:18.34324Z","caller":"traceutil/trace.go:171","msg":"trace[317287804] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:814; }","duration":"129.995385ms","start":"2026-05-29T13:57:18.213232Z","end":"2026-05-29T13:57:18.343228Z","steps":["trace[317287804] 'agreement among raft nodes before linearized reading' (duration: 129.939654ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.343284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.844451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.343319Z","caller":"traceutil/trace.go:171","msg":"trace[1009244332] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:814; }","duration":"129.894982ms","start":"2026-05-29T13:57:18.213414Z","end":"2026-05-29T13:57:18.343309Z","steps":["trace[1009244332] 'agreement among raft nodes before linearized reading' (duration: 129.837911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.343313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.841654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.341949Z","caller":"traceutil/trace.go:171","msg":"trace[1008603370] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:814; }","duration":"235.713791ms","start":"2026-05-29T13:57:18.106226Z","end":"2026-05-29T13:57:18.34194Z","steps":["trace[1008603370] 'agreement among raft nodes before linearized reading' (duration: 235.609819ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:57:18.343428Z","caller":"traceutil/trace.go:171","msg":"trace[107733426] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:814; }","duration":"105.010177ms","start":"2026-05-29T13:57:18.238394Z","end":"2026-05-29T13:57:18.343404Z","steps":["trace[107733426] 'agreement among raft nodes before linearized reading' (duration: 104.851095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.343573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.390821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.343615Z","caller":"traceutil/trace.go:171","msg":"trace[1194151809] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:814; }","duration":"130.458081ms","start":"2026-05-29T13:57:18.213146Z","end":"2026-05-29T13:57:18.343604Z","steps":["trace[1194151809] 'agreement among raft nodes before linearized reading' (duration: 130.402111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.343219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.397611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T13:57:18.343679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.008693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T13:57:18.344014Z","caller":"traceutil/trace.go:171","msg":"trace[1791891374] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:814; }","duration":"175.368509ms","start":"2026-05-29T13:57:18.168632Z","end":"2026-05-29T13:57:18.344Z","steps":["trace[1791891374] 'agreement among raft nodes before linearized reading' (duration: 175.016764ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:57:18.347208Z","caller":"traceutil/trace.go:171","msg":"trace[1003940853] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:814; }","duration":"176.461086ms","start":"2026-05-29T13:57:18.167479Z","end":"2026-05-29T13:57:18.34394Z","steps":["trace[1003940853] 'agreement among raft nodes before linearized reading' (duration: 174.608228ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:57:18.348364Z","caller":"traceutil/trace.go:171","msg":"trace[1833674769] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"1.120698126s","start":"2026-05-29T13:57:17.223599Z","end":"2026-05-29T13:57:18.344297Z","steps":["trace[1833674769] 'process raft request' (duration: 1.117949514s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:18.34852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:57:17.223565Z","time spent":"1.124864778s","remote":"127.0.0.1:53650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T13:57:29.12006Z","caller":"traceutil/trace.go:171","msg":"trace[1137538891] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"124.600074ms","start":"2026-05-29T13:57:28.995409Z","end":"2026-05-29T13:57:29.120009Z","steps":["trace[1137538891] 'process raft request' (duration: 95.007741ms)","trace[1137538891] 'compare' (duration: 29.259396ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:58:07.306807Z","caller":"traceutil/trace.go:171","msg":"trace[1125574788] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"109.291633ms","start":"2026-05-29T13:58:07.197477Z","end":"2026-05-29T13:58:07.306769Z","steps":["trace[1125574788] 'process raft request' (duration: 109.003543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:58:07.606875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.082263ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T13:58:07.607092Z","caller":"traceutil/trace.go:171","msg":"trace[1796953756] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"156.451985ms","start":"2026-05-29T13:58:07.450538Z","end":"2026-05-29T13:58:07.60699Z","steps":["trace[1796953756] 'process raft request' (duration: 40.116413ms)","trace[1796953756] 'compare' (duration: 115.951339ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:58:09.456604Z","caller":"traceutil/trace.go:171","msg":"trace[1069415323] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"140.316128ms","start":"2026-05-29T13:58:09.316252Z","end":"2026-05-29T13:58:09.456568Z","steps":["trace[1069415323] 'process raft request' (duration: 140.156963ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:58:09.756184Z","caller":"traceutil/trace.go:171","msg":"trace[886236509] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"138.33288ms","start":"2026-05-29T13:58:09.617822Z","end":"2026-05-29T13:58:09.756155Z","steps":["trace[886236509] 'process raft request' (duration: 138.153964ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:58:40.098041Z","caller":"traceutil/trace.go:171","msg":"trace[1392640343] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"159.432464ms","start":"2026-05-29T13:58:39.938569Z","end":"2026-05-29T13:58:40.098002Z","steps":["trace[1392640343] 'process raft request' (duration: 113.495512ms)","trace[1392640343] 'compare' (duration: 45.258695ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:59:16.535351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.347813ms","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-29T13:59:16.53553Z","caller":"traceutil/trace.go:171","msg":"trace[1078331129] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1366; }","duration":"423.547262ms","start":"2026-05-29T13:59:16.111961Z","end":"2026-05-29T13:59:16.535508Z","steps":["trace[1078331129] 'range keys from in-memory index tree' (duration: 423.325732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:59:16.535647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.133398ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T13:59:16.535799Z","caller":"traceutil/trace.go:171","msg":"trace[1317797490] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"491.463439ms","start":"2026-05-29T13:59:16.044308Z","end":"2026-05-29T13:59:16.535771Z","steps":["trace[1317797490] 'process raft request' (duration: 50.063779ms)","trace[1317797490] 'compare' (duration: 440.660607ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:59:16.535907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:59:16.044285Z","time spent":"491.587994ms","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T13:59:16.536215Z","caller":"traceutil/trace.go:171","msg":"trace[1790609727] linearizableReadLoop","detail":"{readStateIndex:1427; appliedIndex:1425; }","duration":"489.644057ms","start":"2026-05-29T13:59:16.046557Z","end":"2026-05-29T13:59:16.536201Z","steps":["trace[1790609727] 'read index received' (duration: 47.813798ms)","trace[1790609727] 'applied index is now lower than readState.Index' (duration: 441.828739ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:59:16.536298Z","caller":"traceutil/trace.go:171","msg":"trace[264574569] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"491.949612ms","start":"2026-05-29T13:59:16.044334Z","end":"2026-05-29T13:59:16.536283Z","steps":["trace[264574569] 'process raft request' (duration: 491.758672ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:59:16.536403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.837896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-29T13:59:16.536432Z","caller":"traceutil/trace.go:171","msg":"trace[1907031845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1368; }","duration":"489.89757ms","start":"2026-05-29T13:59:16.046526Z","end":"2026-05-29T13:59:16.536424Z","steps":["trace[1907031845] 'agreement among raft nodes before linearized reading' (duration: 489.753133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:59:16.536467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:59:16.046514Z","time spent":"489.944321ms","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-29T13:59:16.536365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:59:16.044314Z","time spent":"492.016195ms","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T13:59:16.548095Z","caller":"traceutil/trace.go:171","msg":"trace[92600044] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"432.573526ms","start":"2026-05-29T13:59:16.11551Z","end":"2026-05-29T13:59:16.548083Z","steps":["trace[92600044] 'process raft request' (duration: 432.515503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:59:16.548185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:59:16.115487Z","time spent":"432.643339ms","remote":"127.0.0.1:53706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T13:59:16.54828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.152366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-29T13:59:16.548383Z","caller":"traceutil/trace.go:171","msg":"trace[1894701140] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1369; }","duration":"203.330003ms","start":"2026-05-29T13:59:16.345036Z","end":"2026-05-29T13:59:16.548366Z","steps":["trace[1894701140] 'agreement among raft nodes before linearized reading' (duration: 203.056381ms)"],"step_count":1}